builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1465219312.22 results: success (0) buildid: 20160602140837 builduid: 893fdbbbce3544769bc98c5128e2bb0b revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.223943) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.224379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.224649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.269933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.270370) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 06:21:54-- 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% 70.7M=0s 2016-06-06 06:21:54 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162789 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.461430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.461709) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016695 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:52.520318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:21:52.520614) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --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-beta --rev 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --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=e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 06:21:54,310 truncating revision to first 12 chars 2016-06-06 06:21:54,310 Setting DEBUG logging. 2016-06-06 06:21:54,310 attempt 1/10 2016-06-06 06:21:54,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6e2399cf03e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 06:21:55,882 unpacking tar archive at: mozilla-beta-6e2399cf03e2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.908921 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:21:54.444835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:54.445124) ========= script_repo_revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:54.445513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:54.445790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:21:54.457299) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-06 06:21:54.457630) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:21:56 INFO - MultiFileLogger online at 20160606 06:21:56 in /builds/slave/test 06:21:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:21:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:21:56 INFO - {'append_to_log': False, 06:21:56 INFO - 'base_work_dir': '/builds/slave/test', 06:21:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:21:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:21:56 INFO - 'branch': 'Mozilla-Beta', 06:21:56 INFO - 'buildbot_json_path': 'buildprops.json', 06:21:56 INFO - 'config_files': ('talos/linux_config.py',), 06:21:56 INFO - 'default_actions': ('clobber', 06:21:56 INFO - 'read-buildbot-config', 06:21:56 INFO - 'download-and-extract', 06:21:56 INFO - 'populate-webroot', 06:21:56 INFO - 'create-virtualenv', 06:21:56 INFO - 'install', 06:21:56 INFO - 'run-tests'), 06:21:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:21:56 INFO - 'download_minidump_stackwalk': True, 06:21:56 INFO - 'download_symbols': 'ondemand', 06:21:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:21:56 INFO - 'tooltool.py': '/tools/tooltool.py', 06:21:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:21:56 INFO - '/tools/misc-python/virtualenv.py')}, 06:21:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:21:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:21:56 INFO - 'installer_path': 'installer.exe', 06:21:56 INFO - 'log_level': 'info', 06:21:56 INFO - 'log_name': 'talos', 06:21:56 INFO - 'log_to_console': True, 06:21:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:21:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:21:56 INFO - 'opt_config_files': (), 06:21:56 INFO - 'pip_index': False, 06:21:56 INFO - 'sps_profile': False, 06:21:56 INFO - 'sps_profile_interval': 0, 06:21:56 INFO - 'suite': 'dromaeojs-e10s', 06:21:56 INFO - 'system_bits': '32', 06:21:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:21:56 INFO - 'title': 'talos-linux64-ix-067', 06:21:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:21:56 INFO - 'use_talos_json': True, 06:21:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:21:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:21:56 INFO - 'work_dir': 'build'} 06:21:56 INFO - ##### 06:21:56 INFO - ##### Running clobber step. 06:21:56 INFO - ##### 06:21:56 INFO - Running pre-action listener: _resource_record_pre_action 06:21:56 INFO - Running main action method: clobber 06:21:56 INFO - rmtree: /builds/slave/test/build 06:21:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:21:56 INFO - Running post-action listener: _resource_record_post_action 06:21:56 INFO - ##### 06:21:56 INFO - ##### Running read-buildbot-config step. 06:21:56 INFO - ##### 06:21:56 INFO - Running pre-action listener: _resource_record_pre_action 06:21:56 INFO - Running main action method: read_buildbot_config 06:21:56 INFO - Using buildbot properties: 06:21:56 INFO - { 06:21:56 INFO - "project": "", 06:21:56 INFO - "product": "firefox", 06:21:56 INFO - "script_repo_revision": "production", 06:21:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 06:21:56 INFO - "repository": "", 06:21:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 06:21:56 INFO - "buildid": "20160602140837", 06:21:56 INFO - "pgo_build": "True", 06:21:56 INFO - "basedir": "/builds/slave/test", 06:21:56 INFO - "buildnumber": 123, 06:21:56 INFO - "slavename": "talos-linux64-ix-067", 06:21:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:21:56 INFO - "platform": "ubuntu64_hw", 06:21:56 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:21:56 INFO - "branch": "mozilla-beta", 06:21:56 INFO - "repo_path": "releases/mozilla-beta", 06:21:56 INFO - "revision": "6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea", 06:21:56 INFO - "stage_platform": "linux64-pgo", 06:21:56 INFO - "builduid": "893fdbbbce3544769bc98c5128e2bb0b", 06:21:56 INFO - "slavebuilddir": "test" 06:21:56 INFO - } 06:21:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 06:21:56 INFO - Running post-action listener: _resource_record_post_action 06:21:56 INFO - ##### 06:21:56 INFO - ##### Running download-and-extract step. 06:21:56 INFO - ##### 06:21:56 INFO - Running pre-action listener: _resource_record_pre_action 06:21:56 INFO - Running main action method: download_and_extract 06:21:56 INFO - mkdir: /builds/slave/test/build/tests 06:21: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')]} 06:21:56 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:21:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:21:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:21:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:21:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:22:02 INFO - Downloaded 1412 bytes. 06:22:02 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:22:02 INFO - Using the following test package requirements: 06:22:02 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:22:02 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:02 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:22:02 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:02 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 06:22:02 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:02 INFO - u'jsshell-linux-x86_64.zip'], 06:22:02 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:02 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:22:02 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:22:02 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:02 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 06:22:02 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:02 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 06:22:02 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:02 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:22:02 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:22:02 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:22:02 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:22:02 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:02 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:22:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:04 INFO - Downloaded 23434647 bytes. 06:22:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:22:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:22:05 INFO - Return code: 0 06:22:05 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:05 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:22:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:22:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:06 INFO - Downloaded 23434647 bytes. 06:22:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:22:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:22:08 INFO - Return code: 0 06:22:08 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')]} 06:22:08 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:22:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:22:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:22:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:22:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:22:09 INFO - Downloaded 10845194 bytes. 06:22:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:22:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:22:09 INFO - Return code: 0 06:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:09 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:22:11 INFO - Downloaded 53855842 bytes. 06:22:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:11 INFO - mkdir: /builds/slave/test/properties 06:22:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:22:11 INFO - Writing to file /builds/slave/test/properties/build_url 06:22:11 INFO - Contents: 06:22:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:22:12 INFO - Running post-action listener: _resource_record_post_action 06:22:12 INFO - Running post-action listener: set_extra_try_arguments 06:22:12 INFO - ##### 06:22:12 INFO - ##### Running populate-webroot step. 06:22:12 INFO - ##### 06:22:12 INFO - Running pre-action listener: _resource_record_pre_action 06:22:12 INFO - Running main action method: populate_webroot 06:22:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:22:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:22:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:22:12 INFO - '--tppagecycles', 06:22:12 INFO - '7'], 06:22:12 INFO - 'tests': ['tsvgm']}}, 06:22:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:22:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:22:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:22:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:22:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:22:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:22:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:12 INFO - 'talos_options': ['--e10s'], 06:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:12 INFO - 'tests': ['damp', 'tps']}, 06:22:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:12 INFO - 'talos_options': ['--e10s'], 06:22:12 INFO - 'tests': ['damp', 'tps']}, 06:22:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:22:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:22:12 INFO - 'other': {'tests': ['a11yr', 06:22:12 INFO - 'ts_paint', 06:22:12 INFO - 'tpaint', 06:22:12 INFO - 'sessionrestore', 06:22:12 INFO - 'sessionrestore_no_auto_restore', 06:22:12 INFO - 'tabpaint']}, 06:22:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:22:12 INFO - 'tests': ['a11yr', 06:22:12 INFO - 'ts_paint', 06:22:12 INFO - 'tpaint', 06:22:12 INFO - 'sessionrestore', 06:22:12 INFO - 'sessionrestore_no_auto_restore', 06:22:12 INFO - 'tabpaint']}, 06:22:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:22:12 INFO - 'tests': ['a11yr', 06:22:12 INFO - 'ts_paint', 06:22:12 INFO - 'tpaint', 06:22:12 INFO - 'sessionrestore', 06:22:12 INFO - 'sessionrestore_no_auto_restore', 06:22:12 INFO - 'tabpaint']}, 06:22:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:22:12 INFO - 'tests': ['a11yr', 06:22:12 INFO - 'ts_paint', 06:22:12 INFO - 'tpaint', 06:22:12 INFO - 'sessionrestore', 06:22:12 INFO - 'sessionrestore_no_auto_restore', 06:22:12 INFO - 'tabpaint']}, 06:22:12 INFO - 'other_l64': {'tests': ['a11yr', 06:22:12 INFO - 'ts_paint', 06:22:12 INFO - 'tpaint', 06:22:12 INFO - 'sessionrestore', 06:22:12 INFO - 'sessionrestore_no_auto_restore', 06:22:12 INFO - 'tabpaint']}, 06:22:12 INFO - 'other_nol64': {'tests': ['a11yr', 06:22:12 INFO - 'ts_paint', 06:22:12 INFO - 'tpaint', 06:22:12 INFO - 'sessionrestore', 06:22:12 INFO - 'sessionrestore_no_auto_restore', 06:22:12 INFO - 'tabpaint']}, 06:22:12 INFO - 'svgr': {'tests': ['tsvgx', 06:22:12 INFO - 'tsvgr_opacity', 06:22:12 INFO - 'tart', 06:22:12 INFO - 'tscrollx', 06:22:12 INFO - 'cart']}, 06:22:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:22:12 INFO - 'tests': ['tsvgx', 06:22:12 INFO - 'tsvgr_opacity', 06:22:12 INFO - 'tart', 06:22:12 INFO - 'tscrollx', 06:22:12 INFO - 'cart']}, 06:22:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:12 INFO - 'tests': ['tp5o']}, 06:22:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:12 INFO - 'talos_options': ['--e10s'], 06:22:12 INFO - 'tests': ['tp5o']}, 06:22:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:12 INFO - 'talos_options': ['--xperf_path', 06:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:12 INFO - 'tests': ['tp5n']}, 06:22:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:12 INFO - 'talos_options': ['--e10s', 06:22:12 INFO - '--xperf_path', 06:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:12 INFO - 'tests': ['tp5n']}}, 06:22:12 INFO - 'talos.zip': {'path': '', 06:22:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:22:12 INFO - Running post-action listener: _resource_record_post_action 06:22:12 INFO - ##### 06:22:12 INFO - ##### Running create-virtualenv step. 06:22:12 INFO - ##### 06:22:12 INFO - Running pre-action listener: _resource_record_pre_action 06:22:12 INFO - Running main action method: create_virtualenv 06:22:12 INFO - Creating virtualenv /builds/slave/test/build/venv 06:22:12 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 06:22:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:22:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:22:12 INFO - Using real prefix '/usr' 06:22:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:22:12 INFO - Installing distribute.............................................................................................................................................................................................done. 06:22:14 INFO - Installing pip.................done. 06:22:14 INFO - Return code: 0 06:22:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:14 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 0x7fd19852bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', '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 06:22:14 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 06:22:14 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 06:22:14 INFO - Using env: {'DISPLAY': ':0', 06:22:14 INFO - 'HOME': '/home/cltbld', 06:22:14 INFO - 'LANG': 'en_US.UTF-8', 06:22:14 INFO - 'LANGUAGE': 'en_US:en', 06:22:14 INFO - 'LOGNAME': 'cltbld', 06:22:14 INFO - 'MAIL': '/var/mail/cltbld', 06:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:14 INFO - 'MOZ_NO_REMOTE': '1', 06:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:14 INFO - 'NO_EM_RESTART': '1', 06:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:14 INFO - 'PWD': '/builds/slave/test', 06:22:14 INFO - 'SHELL': '/bin/bash', 06:22:14 INFO - 'SHLVL': '1', 06:22:14 INFO - 'TERM': 'linux', 06:22:14 INFO - 'TMOUT': '86400', 06:22:14 INFO - 'USER': 'cltbld', 06:22:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:14 INFO - '_': '/tools/buildbot/bin/python'} 06:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:14 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 06:22:14 INFO - Cleaning up... 06:22:14 INFO - Return code: 0 06:22:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:14 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 0x7fd19852bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', '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 06:22:14 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 06:22:14 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 06:22:14 INFO - Using env: {'DISPLAY': ':0', 06:22:14 INFO - 'HOME': '/home/cltbld', 06:22:14 INFO - 'LANG': 'en_US.UTF-8', 06:22:14 INFO - 'LANGUAGE': 'en_US:en', 06:22:14 INFO - 'LOGNAME': 'cltbld', 06:22:14 INFO - 'MAIL': '/var/mail/cltbld', 06:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:14 INFO - 'MOZ_NO_REMOTE': '1', 06:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:14 INFO - 'NO_EM_RESTART': '1', 06:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:14 INFO - 'PWD': '/builds/slave/test', 06:22:14 INFO - 'SHELL': '/bin/bash', 06:22:14 INFO - 'SHLVL': '1', 06:22:14 INFO - 'TERM': 'linux', 06:22:14 INFO - 'TMOUT': '86400', 06:22:14 INFO - 'USER': 'cltbld', 06:22:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:14 INFO - '_': '/tools/buildbot/bin/python'} 06:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:15 INFO - Downloading/unpacking psutil>=0.7.1 06:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:22:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:17 INFO - Installing collected packages: psutil 06:22:17 INFO - Running setup.py install for psutil 06:22:17 INFO - building 'psutil._psutil_linux' extension 06:22:17 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 06:22:17 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 06:22:17 INFO - building 'psutil._psutil_posix' extension 06:22:17 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 06:22:17 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 06:22:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:17 INFO - Successfully installed psutil 06:22:17 INFO - Cleaning up... 06:22:17 INFO - Return code: 0 06:22:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:22:17 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')]} 06:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:17 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')]} 06:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:17 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 0x7fd19852bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', '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 06:22:17 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 06:22:17 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 06:22:17 INFO - Using env: {'DISPLAY': ':0', 06:22:17 INFO - 'HOME': '/home/cltbld', 06:22:17 INFO - 'LANG': 'en_US.UTF-8', 06:22:17 INFO - 'LANGUAGE': 'en_US:en', 06:22:17 INFO - 'LOGNAME': 'cltbld', 06:22:17 INFO - 'MAIL': '/var/mail/cltbld', 06:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:17 INFO - 'MOZ_NO_REMOTE': '1', 06:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:17 INFO - 'NO_EM_RESTART': '1', 06:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:17 INFO - 'PWD': '/builds/slave/test', 06:22:17 INFO - 'SHELL': '/bin/bash', 06:22:17 INFO - 'SHLVL': '1', 06:22:17 INFO - 'TERM': 'linux', 06:22:17 INFO - 'TMOUT': '86400', 06:22:17 INFO - 'USER': 'cltbld', 06:22:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:17 INFO - '_': '/tools/buildbot/bin/python'} 06:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:22:17 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 06:22:17 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 06:22:17 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 06:22:17 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 06:22:17 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 06:22:17 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 06:22:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:22:19 INFO - Installing collected packages: mozsystemmonitor 06:22:19 INFO - Running setup.py install for mozsystemmonitor 06:22:19 INFO - Successfully installed mozsystemmonitor 06:22:19 INFO - Cleaning up... 06:22:20 INFO - Return code: 0 06:22:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:20 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 0x7fd19852bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', '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 06:22:20 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 06:22:20 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 06:22:20 INFO - Using env: {'DISPLAY': ':0', 06:22:20 INFO - 'HOME': '/home/cltbld', 06:22:20 INFO - 'LANG': 'en_US.UTF-8', 06:22:20 INFO - 'LANGUAGE': 'en_US:en', 06:22:20 INFO - 'LOGNAME': 'cltbld', 06:22:20 INFO - 'MAIL': '/var/mail/cltbld', 06:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:20 INFO - 'MOZ_NO_REMOTE': '1', 06:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:20 INFO - 'NO_EM_RESTART': '1', 06:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:20 INFO - 'PWD': '/builds/slave/test', 06:22:20 INFO - 'SHELL': '/bin/bash', 06:22:20 INFO - 'SHLVL': '1', 06:22:20 INFO - 'TERM': 'linux', 06:22:20 INFO - 'TMOUT': '86400', 06:22:20 INFO - 'USER': 'cltbld', 06:22:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:20 INFO - '_': '/tools/buildbot/bin/python'} 06:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:20 INFO - Downloading/unpacking blobuploader==1.2.4 06:22:20 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 06:22:20 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 06:22:20 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 06:22:20 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 06:22:20 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 06:22:20 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 06:22:22 INFO - Downloading blobuploader-1.2.4.tar.gz 06:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:22:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:22:22 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 06:22:22 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 06:22:22 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 06:22:22 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 06:22:22 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 06:22:22 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 06:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:22:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:22:22 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 06:22:22 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 06:22:22 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 06:22:22 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 06:22:22 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 06:22:22 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 06:22:22 INFO - Downloading docopt-0.6.1.tar.gz 06:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:22:22 INFO - Installing collected packages: blobuploader, requests, docopt 06:22:22 INFO - Running setup.py install for blobuploader 06:22:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:22:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:22:22 INFO - Running setup.py install for requests 06:22:23 INFO - Running setup.py install for docopt 06:22:23 INFO - Successfully installed blobuploader requests docopt 06:22:23 INFO - Cleaning up... 06:22:23 INFO - Return code: 0 06:22:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:23 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 0x7fd19852bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', '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 06:22:23 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 06:22:23 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 06:22:23 INFO - Using env: {'DISPLAY': ':0', 06:22:23 INFO - 'HOME': '/home/cltbld', 06:22:23 INFO - 'LANG': 'en_US.UTF-8', 06:22:23 INFO - 'LANGUAGE': 'en_US:en', 06:22:23 INFO - 'LOGNAME': 'cltbld', 06:22:23 INFO - 'MAIL': '/var/mail/cltbld', 06:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:23 INFO - 'MOZ_NO_REMOTE': '1', 06:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:23 INFO - 'NO_EM_RESTART': '1', 06:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:23 INFO - 'PWD': '/builds/slave/test', 06:22:23 INFO - 'SHELL': '/bin/bash', 06:22:23 INFO - 'SHLVL': '1', 06:22:23 INFO - 'TERM': 'linux', 06:22:23 INFO - 'TMOUT': '86400', 06:22:23 INFO - 'USER': 'cltbld', 06:22:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:23 INFO - '_': '/tools/buildbot/bin/python'} 06:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:22:23 INFO - Running setup.py (path:/tmp/pip-DvZbLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:22:23 INFO - Running setup.py (path:/tmp/pip-WO8ikC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:22:23 INFO - Running setup.py (path:/tmp/pip-wpNqOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:22:23 INFO - Running setup.py (path:/tmp/pip-hDcDyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:22:24 INFO - Running setup.py (path:/tmp/pip-THwloI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:22:24 INFO - Running setup.py (path:/tmp/pip-YsV7EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:22:24 INFO - Running setup.py (path:/tmp/pip-B4XtpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:22:24 INFO - Running setup.py (path:/tmp/pip-oLIg8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:22:24 INFO - Running setup.py (path:/tmp/pip-KC4I0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:22:24 INFO - Running setup.py (path:/tmp/pip-YYvHqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:22:24 INFO - Running setup.py (path:/tmp/pip-bbgF1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:22:24 INFO - Running setup.py (path:/tmp/pip-6irWKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:22:24 INFO - Running setup.py (path:/tmp/pip-EZEreD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:22:24 INFO - Running setup.py (path:/tmp/pip-nHpFJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:24 INFO - Running setup.py (path:/tmp/pip-RVKPnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:22:24 INFO - Running setup.py (path:/tmp/pip-9wHdT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:22:24 INFO - Running setup.py (path:/tmp/pip-ReX1ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:22:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:22:24 INFO - Running setup.py install for manifestparser 06:22:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Running setup.py install for mozcrash 06:22:25 INFO - Running setup.py install for mozdebug 06:22:25 INFO - Running setup.py install for mozdevice 06:22:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Running setup.py install for mozfile 06:22:25 INFO - Running setup.py install for mozhttpd 06:22:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Running setup.py install for mozinfo 06:22:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Running setup.py install for mozInstall 06:22:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Running setup.py install for mozleak 06:22:25 INFO - Running setup.py install for mozlog 06:22:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:22:25 INFO - Running setup.py install for moznetwork 06:22:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:22:26 INFO - Running setup.py install for mozprocess 06:22:26 INFO - Running setup.py install for mozprofile 06:22:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:22:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:22:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:22:26 INFO - Running setup.py install for mozrunner 06:22:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:22:26 INFO - Running setup.py install for mozscreenshot 06:22:26 INFO - Running setup.py install for moztest 06:22:26 INFO - Running setup.py install for mozversion 06:22:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:22:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:22:26 INFO - Cleaning up... 06:22:26 INFO - Return code: 0 06:22:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:26 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')]} 06:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:26 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')]} 06:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:26 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 0x7fd19852bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', '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 06:22:26 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 06:22:26 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 06:22:26 INFO - Using env: {'DISPLAY': ':0', 06:22:26 INFO - 'HOME': '/home/cltbld', 06:22:26 INFO - 'LANG': 'en_US.UTF-8', 06:22:26 INFO - 'LANGUAGE': 'en_US:en', 06:22:26 INFO - 'LOGNAME': 'cltbld', 06:22:26 INFO - 'MAIL': '/var/mail/cltbld', 06:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:26 INFO - 'MOZ_NO_REMOTE': '1', 06:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:26 INFO - 'NO_EM_RESTART': '1', 06:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:26 INFO - 'PWD': '/builds/slave/test', 06:22:26 INFO - 'SHELL': '/bin/bash', 06:22:26 INFO - 'SHLVL': '1', 06:22:26 INFO - 'TERM': 'linux', 06:22:26 INFO - 'TMOUT': '86400', 06:22:26 INFO - 'USER': 'cltbld', 06:22:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:26 INFO - '_': '/tools/buildbot/bin/python'} 06:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:22:26 INFO - Running setup.py (path:/tmp/pip-zaOPKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:22:27 INFO - Running setup.py (path:/tmp/pip-TXd4kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:22:27 INFO - Running setup.py (path:/tmp/pip-tmqfed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:22:27 INFO - Running setup.py (path:/tmp/pip-WOAaVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:22:27 INFO - Running setup.py (path:/tmp/pip-4_u3AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:22:27 INFO - Running setup.py (path:/tmp/pip-Qykpv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:22:27 INFO - Running setup.py (path:/tmp/pip-sEWae9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:22:27 INFO - Running setup.py (path:/tmp/pip-RGKWiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:22:27 INFO - Running setup.py (path:/tmp/pip-Fxefkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:22:27 INFO - Running setup.py (path:/tmp/pip-msndlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:22:27 INFO - Running setup.py (path:/tmp/pip-lKdZEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:22:27 INFO - Running setup.py (path:/tmp/pip-Qfbldc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:22:27 INFO - Running setup.py (path:/tmp/pip-KufsHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:22:27 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)) 06:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:22:27 INFO - Running setup.py (path:/tmp/pip-b57zNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:22:28 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)) 06:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:28 INFO - Running setup.py (path:/tmp/pip-1vzaCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:28 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)) 06:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:22:28 INFO - Running setup.py (path:/tmp/pip-7CVYoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:22:28 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)) 06:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:22:28 INFO - Running setup.py (path:/tmp/pip-411Uya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:22:28 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)) 06:22:28 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)) 06:22:28 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)) 06:22:28 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)) 06:22:28 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)) 06:22:28 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)) 06:22:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:22:28 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 06:22:28 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 06:22:28 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 06:22:28 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 06:22:28 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 06:22:28 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 06:22:30 INFO - Downloading blessings-1.6.tar.gz 06:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:22:30 INFO - Installing collected packages: blessings 06:22:30 INFO - Running setup.py install for blessings 06:22:30 INFO - Successfully installed blessings 06:22:30 INFO - Cleaning up... 06:22:30 INFO - Return code: 0 06:22:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:22:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:30 INFO - Reading from file tmpfile_stdout 06:22:30 INFO - Current package versions: 06:22:30 INFO - argparse == 1.2.1 06:22:30 INFO - blessings == 1.6 06:22:30 INFO - blobuploader == 1.2.4 06:22:30 INFO - docopt == 0.6.1 06:22:30 INFO - manifestparser == 1.1 06:22:30 INFO - mozInstall == 1.12 06:22:30 INFO - mozcrash == 0.17 06:22:30 INFO - mozdebug == 0.1 06:22:30 INFO - mozdevice == 0.48 06:22:30 INFO - mozfile == 1.2 06:22:30 INFO - mozhttpd == 0.7 06:22:30 INFO - mozinfo == 0.9 06:22:30 INFO - mozleak == 0.1 06:22:30 INFO - mozlog == 3.1 06:22:30 INFO - moznetwork == 0.27 06:22:30 INFO - mozprocess == 0.22 06:22:30 INFO - mozprofile == 0.28 06:22:30 INFO - mozrunner == 6.11 06:22:30 INFO - mozscreenshot == 0.1 06:22:30 INFO - mozsystemmonitor == 0.0 06:22:30 INFO - moztest == 0.7 06:22:30 INFO - mozversion == 1.4 06:22:30 INFO - psutil == 3.1.1 06:22:30 INFO - requests == 1.2.3 06:22:30 INFO - wsgiref == 0.1.2 06:22:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:30 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 0x7fd19852bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', '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 06:22:30 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 06:22:30 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 06:22:30 INFO - Using env: {'DISPLAY': ':0', 06:22:30 INFO - 'HOME': '/home/cltbld', 06:22:30 INFO - 'LANG': 'en_US.UTF-8', 06:22:30 INFO - 'LANGUAGE': 'en_US:en', 06:22:30 INFO - 'LOGNAME': 'cltbld', 06:22:30 INFO - 'MAIL': '/var/mail/cltbld', 06:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:30 INFO - 'MOZ_NO_REMOTE': '1', 06:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:30 INFO - 'NO_EM_RESTART': '1', 06:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:30 INFO - 'PWD': '/builds/slave/test', 06:22:30 INFO - 'SHELL': '/bin/bash', 06:22:30 INFO - 'SHLVL': '1', 06:22:30 INFO - 'TERM': 'linux', 06:22:30 INFO - 'TMOUT': '86400', 06:22:30 INFO - 'USER': 'cltbld', 06:22:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:30 INFO - '_': '/tools/buildbot/bin/python'} 06:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:30 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)) 06:22:30 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)) 06:22:30 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)) 06:22:30 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)) 06:22:30 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)) 06:22:30 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)) 06:22:30 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)) 06:22:30 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)) 06:22:30 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)) 06:22:30 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)) 06:22:30 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)) 06:22:30 INFO - Cleaning up... 06:22:30 INFO - Return code: 0 06:22:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:30 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 0x7fd19852bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', '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 06:22:30 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 06:22:30 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 06:22:30 INFO - Using env: {'DISPLAY': ':0', 06:22:30 INFO - 'HOME': '/home/cltbld', 06:22:30 INFO - 'LANG': 'en_US.UTF-8', 06:22:30 INFO - 'LANGUAGE': 'en_US:en', 06:22:30 INFO - 'LOGNAME': 'cltbld', 06:22:30 INFO - 'MAIL': '/var/mail/cltbld', 06:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:30 INFO - 'MOZ_NO_REMOTE': '1', 06:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:30 INFO - 'NO_EM_RESTART': '1', 06:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:30 INFO - 'PWD': '/builds/slave/test', 06:22:30 INFO - 'SHELL': '/bin/bash', 06:22:30 INFO - 'SHLVL': '1', 06:22:30 INFO - 'TERM': 'linux', 06:22:30 INFO - 'TMOUT': '86400', 06:22:30 INFO - 'USER': 'cltbld', 06:22:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:30 INFO - '_': '/tools/buildbot/bin/python'} 06:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:31 INFO - Downloading/unpacking jsonschema 06:22:31 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 06:22:31 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 06:22:31 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 06:22:31 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 06:22:31 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 06:22:31 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 06:22:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:22:32 INFO - Downloading/unpacking functools32 (from jsonschema) 06:22:32 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 06:22:32 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 06:22:32 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 06:22:32 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 06:22:32 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 06:22:32 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 06:22:33 INFO - Downloading functools32-3.2.3-2.tar.gz 06:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:22:33 INFO - warning: no files found matching '*.txt' 06:22:33 INFO - no previously-included directories found matching 'build' 06:22:33 INFO - no previously-included directories found matching 'dist' 06:22:33 INFO - no previously-included directories found matching '.git*' 06:22:33 INFO - Installing collected packages: jsonschema, functools32 06:22:33 INFO - Running setup.py install for functools32 06:22:33 INFO - warning: no files found matching '*.txt' 06:22:33 INFO - no previously-included directories found matching 'build' 06:22:33 INFO - no previously-included directories found matching 'dist' 06:22:33 INFO - no previously-included directories found matching '.git*' 06:22:33 INFO - Successfully installed jsonschema functools32 06:22:33 INFO - Cleaning up... 06:22:33 INFO - Return code: 0 06:22:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:22:33 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')]} 06:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:33 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')]} 06:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:33 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 0x7fd19852bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', '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 06:22:33 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 06:22:33 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 06:22:33 INFO - Using env: {'DISPLAY': ':0', 06:22:33 INFO - 'HOME': '/home/cltbld', 06:22:33 INFO - 'LANG': 'en_US.UTF-8', 06:22:33 INFO - 'LANGUAGE': 'en_US:en', 06:22:33 INFO - 'LOGNAME': 'cltbld', 06:22:33 INFO - 'MAIL': '/var/mail/cltbld', 06:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:33 INFO - 'MOZ_NO_REMOTE': '1', 06:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:33 INFO - 'NO_EM_RESTART': '1', 06:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:33 INFO - 'PWD': '/builds/slave/test', 06:22:33 INFO - 'SHELL': '/bin/bash', 06:22:33 INFO - 'SHLVL': '1', 06:22:33 INFO - 'TERM': 'linux', 06:22:33 INFO - 'TMOUT': '86400', 06:22:33 INFO - 'USER': 'cltbld', 06:22:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:33 INFO - '_': '/tools/buildbot/bin/python'} 06:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:33 INFO - Downloading/unpacking flake8 06:22:33 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 06:22:33 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 06:22:33 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 06:22:33 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 06:22:33 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 06:22:33 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 06:22:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:22:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:22:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 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 06:22:35 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 06:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:22:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:36 INFO - no previously-included directories found matching 'docs/_build' 06:22:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:22:36 INFO - Running setup.py install for pep8 06:22:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:36 INFO - no previously-included directories found matching 'docs/_build' 06:22:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:22:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:22:36 INFO - Cleaning up... 06:22:36 INFO - Return code: 0 06:22:36 INFO - Running post-action listener: _resource_record_post_action 06:22:36 INFO - Running post-action listener: _start_resource_monitoring 06:22:36 INFO - Starting resource monitoring. 06:22:36 INFO - ##### 06:22:36 INFO - ##### Running install step. 06:22:36 INFO - ##### 06:22:36 INFO - Running pre-action listener: _resource_record_pre_action 06:22:36 INFO - Running main action method: install 06:22:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:36 INFO - Reading from file tmpfile_stdout 06:22:36 INFO - Detecting whether we're running mozinstall >=1.0... 06:22:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:22:36 INFO - Reading from file tmpfile_stdout 06:22:36 INFO - Output received: 06:22:36 INFO - Usage: mozinstall [options] installer 06:22:36 INFO - Options: 06:22:36 INFO - -h, --help show this help message and exit 06:22:36 INFO - -d DEST, --destination=DEST 06:22:36 INFO - Directory to install application into. [default: 06:22:36 INFO - "/builds/slave/test"] 06:22:36 INFO - --app=APP Application being installed. [default: firefox] 06:22:36 INFO - mkdir: /builds/slave/test/build/application 06:22:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:22:49 INFO - Reading from file tmpfile_stdout 06:22:49 INFO - Output received: 06:22:49 INFO - /builds/slave/test/build/application/firefox/firefox 06:22:49 INFO - Running post-action listener: _resource_record_post_action 06:22:49 INFO - ##### 06:22:49 INFO - ##### Running run-tests step. 06:22:49 INFO - ##### 06:22:49 INFO - Running pre-action listener: _resource_record_pre_action 06:22:49 INFO - Running main action method: run_tests 06:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:22:49 INFO - Python 2.7.3 06:22:49 INFO - Return code: 0 06:22:49 INFO - grabbing minidump binary from tooltool 06:22: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')]} 06:22:49 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 0x1a57160>, '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 0x1a58060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a584f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:22:49 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 06:22:49 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 06:22:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:22:49 INFO - Return code: 0 06:22:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:22:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:22:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:22:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:22:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:22:50 INFO - Return code: 0 06:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 06:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 06:22:50 INFO - Using env: {'DISPLAY': ':0', 06:22:50 INFO - 'HOME': '/home/cltbld', 06:22:50 INFO - 'LANG': 'en_US.UTF-8', 06:22:50 INFO - 'LANGUAGE': 'en_US:en', 06:22:50 INFO - 'LOGNAME': 'cltbld', 06:22:50 INFO - 'MAIL': '/var/mail/cltbld', 06:22:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:22:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:50 INFO - 'MOZ_NO_REMOTE': '1', 06:22:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:50 INFO - 'NO_EM_RESTART': '1', 06:22:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:50 INFO - 'PWD': '/builds/slave/test', 06:22:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:22:50 INFO - 'SHELL': '/bin/bash', 06:22:50 INFO - 'SHLVL': '1', 06:22:50 INFO - 'TERM': 'linux', 06:22:50 INFO - 'TMOUT': '86400', 06:22:50 INFO - 'USER': 'cltbld', 06:22:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013', 06:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:50 INFO - '_': '/tools/buildbot/bin/python'} 06:22:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 06:22:50 INFO - mozversion application_buildid: 20160602140837 06:22:50 INFO - mozversion application_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:22:50 INFO - mozversion application_display_name: Firefox 06:22:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:22:50 INFO - mozversion application_name: Firefox 06:22:50 INFO - mozversion application_remotingname: firefox 06:22:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:22:50 INFO - mozversion application_vendor: Mozilla 06:22:50 INFO - mozversion application_version: 47.0 06:22:50 INFO - mozversion platform_buildid: 20160602140837 06:22:50 INFO - mozversion platform_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:22:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:22:50 INFO - mozversion platform_version: 47.0 06:22:50 INFO - using testdate: 1465219370 06:22:50 INFO - actual date: 1465219370 06:22:50 INFO - starting webserver on 'localhost:44848' 06:22:50 INFO - SUITE-START | Running 2 tests 06:22:50 INFO - TEST-START | dromaeo_css 06:22:50 INFO - operating with platform_type : linux_ 06:22:50 INFO - Initialising browser for dromaeo_css test... 06:22:50 INFO - TEST-INFO | started process 16361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_gEIKj/profile http://localhost:44848/getInfo.html) 06:22:53 INFO - PROCESS | 16361 | 06:22:53 INFO - PROCESS | 16361 | (process:16439): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:22:54 INFO - PROCESS | 16361 | __metrics Screen width/height:1600/1200 06:22:54 INFO - PROCESS | 16361 | colorDepth:24 06:22:54 INFO - PROCESS | 16361 | Browser inner width/height: 1024/697 06:22:54 INFO - PROCESS | 16361 | __metrics 06:22:55 ERROR - PROCESS | 16361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:22:55 INFO - TEST-INFO | 16361: exit 0 06:22:55 INFO - Browser initialized. 06:22:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:22:55 INFO - TEST-INFO | started process 16489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_gEIKj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:57 INFO - PROCESS | 16489 | 06:22:57 INFO - PROCESS | 16489 | (process:16558): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:23:07 INFO - PROCESS | 16489 | RSS: Main: 150007808 06:23:07 INFO - PROCESS | 16489 | 06:23:57 INFO - PROCESS | 16489 | 1465219437343 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] 06:26:05 INFO - PROCESS | 16489 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44848/tests/dromaeo/cssquery-ext.html) 06:26:06 INFO - PROCESS | 16489 | RSS: Main: 153706496 06:26:06 INFO - PROCESS | 16489 | 06:29:08 INFO - PROCESS | 16489 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-ext.html (next: http://localhost:44848/tests/dromaeo/cssquery-jquery.html) 06:29:08 INFO - PROCESS | 16489 | RSS: Main: 152739840 06:29:08 INFO - PROCESS | 16489 | 06:32:10 INFO - PROCESS | 16489 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44848/tests/dromaeo/cssquery-mootools.html) 06:32:10 INFO - PROCESS | 16489 | RSS: Main: 151977984 06:32:10 INFO - PROCESS | 16489 | 06:35:12 INFO - PROCESS | 16489 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44848/tests/dromaeo/cssquery-prototype.html) 06:35:13 INFO - PROCESS | 16489 | RSS: Main: 152850432 06:35:13 INFO - PROCESS | 16489 | 06:38:15 INFO - PROCESS | 16489 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44848/tests/dromaeo/cssquery-yui.html) 06:38:16 INFO - PROCESS | 16489 | RSS: Main: 151539712 06:38:16 INFO - PROCESS | 16489 | 06:41:17 INFO - PROCESS | 16489 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-yui.html (next: http://localhost:44848/tests/dromaeo/cssquery-dojo.html) 06:41:18 INFO - PROCESS | 16489 | RSS: Main: 155684864 06:41:18 INFO - PROCESS | 16489 | 06:41:18 INFO - PROCESS | 16489 | __start_tp_report 06:41:18 INFO - PROCESS | 16489 | _x_x_mozilla_page_load 06:41:18 INFO - PROCESS | 16489 | _x_x_mozilla_page_load_details 06:41:18 INFO - PROCESS | 16489 | |i|pagename|runs| 06:41:18 INFO - PROCESS | 16489 | |0;dojo.html;3351.5978082630086;3418.846151923164;3422.195783990763;3426.3832510148163;3458.481227815829;5507.504324610784;5556.111022236443;5591;5600.019996500617;5603.859903502414;5560.082586373253;5610.046292130338;5612.66324020559;5620.803271885475;5621.859453513664;5065.062963351783;5131.974340128294;5167.405748338932;5183.067047931371;5203.089459344618;4918.311436398907;5049.621278404116;5242.370915490146;5266.4733526647415;5286.841394758163;5094.133997220463;5105.5149760772665;5114.079465696173;5209.192575150839;5223.477652234784;5168.767405466744;5187.247849061865;5188.662736922088;5210.218467229945;5211.478852114796;4919.581835543983;5000.449950505442;5184.144616138333;5192.039472697563;5231.424543300234;5435.537979271767;5450.3732070811575;5458.1266997280245;5464.754086066137;5477.863053423656;5999.730012149464;6036.547258955552;6040.728167232485;6047.969760151215;6052.636841789506;5918.348981612019;5995.070764031539;6064.605800622945;6103.511719062464;6115.755369785204;5571.164325351189;5597.944020559824;5600.411956744565;5601.943980560183;5611.0741727614895;6098.969505152446;6105.175801266772;6107.786227482017;6117.265928088658;6117.969410153009;5767.077267637158;5847.707614619252;5925.140854576062;5956.225690660186;5977.193078934375;5940;5940.732667029994;5942.078977758368;5943.613665111754;5968.731407086691;5819.923314186889;5825.912611310834;5892.292924849045;5903.881922361528;5925.674087925119;5892.764289428461;5983.37174596661;5984.970075149684;5994.190784244159;6027.306859711101;4489.483709373464;4504.932426013613;4529.139463501924;4532.9773351133035;4558.749268790249;3997.060690737674;4034.65705415043;4056.7363121397016;4084.81618327176;4117.691173162025;5400.513953744182;5446.782128714807;5659.094544872801;5682;5722.084466485342;6063.029915213545;6063.8484037898525;6067.908981365283;6071.878562428727;6078.392160783975;5553.389127196006;5724.026915424388;5734.799282025193;5746.597738158289;5754.625949313281;5137.049645815536;5173.094708426086;5191.428942816287;5194.039102766001;5215.217717342429;6169.629822210592;6211.068339749074;6233.594816337014;6239;6240.188775459252;5905.527557795452;5974;6011.819645410645;6022.518198544019;6026.427489388501;6129.14485165794;6151.292601350723;6167.599106058092;6180.783672571439;6182.505399567934;5897.498712609477;5906.7341969612335;5910.438508341701;5912.733926973383;5918.644881307136;5861.736221869941;5965.135055417027;5992.460678538952;6032.819015429544;6061.302950160788;5922.111683247375;5930.258717660293;5936.7922122725495;5942.376050514807;5950.137230101697;5852.209951656472;5907.113932910098;5938.346781854079;5939.406059394199;5942.078977758454;5577.693226872561;5760.539156867524;5813.09896965971;5822.912656310074;5862.853428664317;5818.76724930998;5858.560607954335;5859.589828711949;5870.706464676835;5872;5742;5747.252857128547;5749.8562535936935;5773.826785196451;5778.364379918122 06:41:18 INFO - PROCESS | 16489 | |1;ext.html;513.194284972593;533.6744585802661;540.2382640476928;540.3542766394161;556.7355506134585;31325.843370783143;39888.202235955265;40347.394789078186;40370;40388.39417408738;43808.342874856826;44609.330860037124;44704.55295447045;44769.10461790762;44898.1020379593;8775.341849361308;8940.15068568485;8956.373053886198;8970.596323165473;8989.505577193284;8864.335174861879;9009.594568244413;9016.323775716815;9024.413413128159;9028.277737780994;8948.239399651005;9044.186023257906;9045.050269721683;9068.773280668003;9076.682316118937;8871;8975.820483590356;8987.191152796247;9045;9047.954760226223;8789.604467798965;8909.242714369286;8912.24245939096;8915.777105572348;9152.222061124812;44994.325085123746;45252;45315;45323.77338113288;45339.319910201375;3476.9826150869335;3511.8595256189724;3561.0741207286032;3643.508126402928;3668.137987572918;32532.18669533257;32838;33351.666483335095;33361.16597085068;33556.32887342264;3571.785692858411;3649.197176621139;3665.6700896919406;3724.7206459515646;3742.7567208131386;288666;289171;289584;290192;290382;45927.31109033367;46754.5324546757;58127.709361453766;58631.41368586345;58717.70641146853;44849.32726009112;44894.551054489035;44940.55059449429;44949.77525112354;45176.77411612987;17087.316507339816;17345.65308693819;17349.7397539037;17350.132493375535;17404.564885877702;13594.660133496543;13761.449542018207;13767.242801646005;13847.861521384859;13853.792193117111;15229.923850380677;15721.842781572266;15820.05079695222;15927.362905483651;15943.920280398755;5975.37258587842;5975.671338076448;6100.603460775035;6137.232845894263;6172.969135154295;1033.333499892565;1035.1615191694752;1056.4189695667353;1062.5271754069365;1140.8363469261308;30740.69259307423;30741;31010.379792404026;31103.844480777905;31111;1122.7978963786434;1135.5684839761004;1184.8222766584909;1214.678110300771;1218.975620487603;15643.452479163174;15755;15819.920900395424;16027.919860400856;16031.519054428385;320874;644291;814477;819017;828485;63173;63198.47206111704;63865;63887.36112638907;63944;1464.0849469081825;1469.9118052916858;1491.7986071880157;1494.3723636072875;1535.1940231378614;31799.205019874687;31816;32247.838760806048;32276.515852261764;32443.351132976735;51288.230676540625;51921;51923;51963.740181298854;52045.47954520558;306190;312373;312596;313273;313617;32220.033398998068;32477;32812.83593582017;34588.48117278293;35040.82479587586;47346.76326618345;47898.76050619724;48053.27920081132;48383.5161648379;49161.508384915694;38533.42199866948;38949.41575876421;39199.216015678954;39664.60335396609;39744.40383394309;37928;39557.60442395539;39814.60185398109;39930.80034599925;40105.39841902316;39980.600193997685;40124.19751604893;40156.79921600373;40220.1955960885;41036.58963410328;34204;34933.301333973686;35762.8211858939;35899.28201436009;35914;26938.326541835828;27407.17778466649;27434.314142146606;27547.86226068857;27692.86153569219 06:41:18 INFO - PROCESS | 16489 | |2;jquery.html;367.30945821854925;368.8395547936648;376.4315883016645;378.11521040764603;378.7954504567534;17648.38230661927;17866.28534858604;18600;18605.534861628465;18621.90689046556;18715.532111697215;19230.423087307405;19317.227310907547;19478.902605486954;19501.609967800672;5609.887802243942;5851.853703657422;5872.265966754156;5881.617694849842;5884.323302820167;5654.349749778787;5763.164341170528;5812.796552120655;5853.853653658672;5862.736176872051;5750.482456578907;5751.82744517663;5755.712214389285;5762.250907382035;5763.769449222026;5546.4453554644615;5700.486956173964;5711.343195532505;5732.140178973145;5735.655860648353;5098.745062746848;5107.438181799999;5131.923021154686;5132.769025393866;5136.897262054738;22072.668909966364;22102.77897221023;22259.44351391212;22407.55184896293;22650.88674556633;2279.031411650042;2312.2947501012186;2441.523902838947;2526.835755675894;3101.7983831051133;13846;13931.233782141979;14311.427542898271;14349.210793406359;14361.856381436157;1952.6192392483472;2009.1461129020254;2018.1523760020827;2022.8280596149345;2038.6330460517102;57393;62205;64148.679256603886;65222.347776522576;69820.6508967457;10617.256792024484;10764.3541387517;11035.172362072877;11053.723656908642;11169.776604467865;15660.295286712126;15751.606209844616;15772.842271577367;15782.131982741059;15803.841961580467;8410.78973025667;8642.611082501302;8677.045524992245;8711.477311361212;8720;8496.362772792065;8504.53225072627;8577.528235946958;8599.355048371397;8620.741377758677;4786.2820576913045;4859.198232291703;4882.536159064884;4886.706797592155;4914;1945.4260993007097;1956.9217231310872;1981.4253866378588;1986.2154448992567;2027.1891243502423;941.4445477168366;943.7593413679605;984.7144328144758;992.3351354592296;1049.3231865446896;17840.643187136186;17854.37509687181;17991.73012404815;18273.90863045676;18471.630567388846;992.2161492421051;1011.1203253169789;1015.5480811039164;1050.8423736439595;1118.625260537729;10240.539175737109;10429.634962776267;10435.582576697;10474.68575942723;10537.587499256362;433134;434437;450050;458421;459485;71761;75397.24602754012;78368;80660;81148.59425702952;1040.5837664934088;1041.9374837509774;1090.3022065878004;1093.7703082352637;1102.9393383363831;15723.213839308217;15831.129287889276;16172.353105876104;16186.190690465664;16311.67376652484;32716;32952.176195595304;33438;33570.32859342849;34782.65217347794;48291.75854120707;51482.742586288325;51519;51665.48334516607;52079.218811717095;8306.70926517569;8578.742637720628;8611.82776344482;8850.557472126497;8924.152205540722;12434.253944763343;12462.563810266598;12531.93734031324;12709.989836790875;13912.234827084607;11383.54465821358;11534.884651153381;11586.073114151017;11771.823422648838;11838.230515016496;10810.29733067348;11433.714157146138;11473.82789258145;12121.090918180995;12198.878011219775;11104;11138.27601205919;11442.141839362248;11461;11939.761204775683;8350.540720260202;8359.498430094214;8406.705765298186;8503.447275927045;8527.062023177321;11401;11838.585649502225;11892.76214475723;11905.40472976365;12017.519299227934 06:41:18 INFO - PROCESS | 16489 | |3;mootools.html;1549.2253873063469;1596.7525033619786;1824.1426529531125;1854.5919897622518;1925.846919093496;7466.925330746691;8176.632051557679;8212.548309842956;8482.066972633005;8520.872186917193;8296.543690097042;8321.667133314675;8368.539730314831;8390.874136887951;8401.201885820838;2386.439186791107;2398.724146723123;2407.6990376202975;2413.6017557103055;2415.3478560788576;2226.0984301357894;2240.5854916840435;2262.6492893601517;2263.1852533088077;2266.1275408967585;2380.5476959377747;2402.1112188490283;2408.446057406789;2417.528581926525;2418.625113107471;2410.6625072489865;2426.3934016495878;2430.732619411863;2435.7929575985972;2442.9511409771794;2406.9037238510437;2412.3245491262473;2421.418859473731;2426.9514609707885;2437.4150203951103;8584.098669639661;8592.355573331963;8613.181747733955;8616.224539791387;8670.956645216796;5231.398389185254;5365.651232669903;5367.704776237305;5375.274337964363;5387.164989426645;3127.233827712202;3162.826044567548;3190.6490286068515;3304.157439852846;3377.3245350929665;1069.3904474449566;1088.2219213262556;1089.7929393415225;1090.2150451674781;1094.9610961512742;11980.999999999913;12087.153899227058;12102.697432564168;12103.515859365614;12103.697407564881;4529.162105010583;4565.269556870885;4569.314602809539;4647.419072615923;4666.580007799246;10191.847122293171;10198.082172604501;10199.796004080024;10201.081902628799;10209.234307426972;5373.7581808818695;5381.461853814665;5392.703401312887;5393.1370980642905;5395.865103372368;4727.858164255078;4808.903821923542;4854.393200849894;4867;4899.755012249373;3628.546431696038;3683.336999340091;3704.370257056253;3706.425504046877;3715.6098609646137;1071.3625392891217;1115.7712668902855;1116.815725405299;1119.367557330106;1119.8544189255344;1105.8230683090828;1162.1167912386477;1167.287954347847;1181.480148734554;1183.8520184976878;7878.409119316074;7980.162082981319;7994.160613135653;8024.2376974187355;8035.236652518001;1212.721074152932;1215.2161855603088;1222.4560070768423;1236.0729452910318;1238.6779437346354;6042.728077236535;6115.84710382244;6191.907121393183;6193.040078787795;6198.504119670415;10061.54723037465;10266.538005789758;10286.742831429274;10292.639757608447;10467.162626989822;10147.695569132939;10411.427371494488;10436.269461137648;10584.470776461147;10584.788304233873;8004.63979120941;8081.272685458454;8167.918320816834;8169.836603268021;8216.808562758366;7643.350315223268;7662.923370766221;7732.574708391093;7797.376209903081;7885.763427097197;8680.652773888974;8929.642814287616;9127.863082053907;9206.355555111346;9332.533373331442;9139.77150571241;9186.127317904788;9276.582553784961;9377.765555860886;9586.568604412958;7868.685252589832;8058.476199047043;8098.635561399869;8117.391195660467;8328.042275138436;8122.309603683753;8191.590420478833;8213.3429325655;8261.793455163668;8262.925819643408;6854.074699915647;7231.349178573953;7462.328390444886;7537.585432801248;7567;7022.473314501331;7179.748708795167;7181.35367816899;7300.598467084362;7319.560826350436;7340.302671246223;7403.51877127985;7437.553746774995;7479.88780168287;7494.288042635941;6771.52599318043;6843.931560684528;6852.246252912275;6857.622830744357;6894.724211031503;6929.411000065051;6931.341522555349;6967.512274140761;7014.123234595676;7075.433965282662 06:41:18 INFO - PROCESS | 16489 | |4;prototype.html;322.3922905323466;342.1292809799061;344.1550992313869;350.13341978602944;352.70725298002645;6375.362463753628;6375.744970201198;6406.231252249725;6408.295087540367;6418.582792118509;6329.651869147195;6347.17486726726;6349.904751428732;6350.301466838644;6362.109304697335;4679.789409476564;4765.809367625308;4799.472058073609;4803.663743537953;4898.7060776353355;4773.5226477352335;4790.209615413452;4795.0889331027165;4799.928001079987;4808.254720518308;4727.550882666142;4730.787114579835;4739.928901066487;4747.667663263573;4758.643101767364;4747.667663263573;4747.691400058985;4753.215719406294;4759.048190361907;4762.78567464465;4102.056526998807;4103.199876024177;4103.4460347852955;4107.589241075869;4110.445089912853;6032.125341825411;6047.485963693091;6062.757489700451;6068.120122582201;6068.6358818471035;5464.754086066137;5600.467955544217;5618.0449323614675;5621.100623900156;5650.915236271459;6713.12729345182;6714.563553369016;6726.192856857208;6730.966345168243;6735.461163106988;4646.140464014168;4655.022445286494;4655.045715628288;4656.859069527954;4660.86017419478;6974.686139123752;6986.54587451819;7036.261192574808;7038.753643622448;7048.18945821232;4519.909601807945;4732.124556956974;4739.620830333565;4741.715497070118;4756.8097276108565;4708.882277943078;4709.764511774466;4715.717056976524;4718.268668356411;4740.312654665123;5499.697516636624;5513.972430137824;5516.062269414209;5519.889602207933;5531.004419204502;6762.053312536249;6763.323667633295;6767.729290828312;6772.288909664513;6803.795886123424;1686.1822016322074;1711.5806627376123;1713.8628909687195;1713.9143042847809;1717.029878118859;1094.0973696700255;1117.3240189685287;1122.2256642916361;1127.2391135983178;1140.1961617059953;6425.421712045938;6464.773732919325;6482.611043337415;6485.77299794505;6496.837579060561;6953.061336719579;6955.513114082067;6973.825654358681;6976.720931162697;6996.790096297017;6346.428821406095;6444.484441244689;6501.0898474213645;6540.509461790385;6554.246261679872;3788.8484460621817;3830.5211848518934;3833.0609000794984;3834.69322454203;3835.0987517933263;7277.2358902315555;7304.415646748247;7317.890231646529;7327.523710958771;7342.596157211405;7211.711531538785;7225.819354516179;7231.16841563227;7251.8187045324285;7260;7050.189228238715;7261.41908647307;7313.561186328838;7317.780466586118;7319.560826350329;7035.155781306072;7045.225025247321;7051.5063945523325;7059.54112982675;7068.29317068289;6928.896066558905;6948.305169483011;6955.617441040589;6958.06066181059;6961.721531138698;7328.450366222448;7336.486445948733;7342.853142937004;7343.48595598303;7357.668904899399;4787.3776409066595;4807.663463557517;4947.455779864284;4948.678335908298;4952.851414457572;6953.826154346182;6963.2340442552295;6999.61502117368;7003.404710599452;7021.087258656342;6802.693878775566;6808.9659551701925;6822.727090916308;6852.554583952027;6884.827879303058;6851.828704282433;6853.828654283683;6860;6862.176538815374;6893.379595836399;6529.444997175104;6628.734850605922;6742.786298466323;6743.7639682612835;6748.662566871735;6867.3476019778045;6881.793546193622;6882.414994725505;6888.552244104118;6897.206821215424;6725.461963042847;6785.321467853175;6789.966050169717;6790.185177778698;6792.626405547742 06:41:18 INFO - PROCESS | 16489 | |5;yui.html;754.4492520460066;814.2956342763512;818.8444195602835;866.6879923227641;883.8674198870173;16696.582585435353;16863;17044.0625765583;17050.573735656613;17160.313587456487;15587.53237402877;15677.84322156778;15713.607159821011;15720.84279157208;15721.764173537378;933.5332333833084;952.6332362040595;953.7138858342504;959.4866746290701;971.616211596419;967.6226271754022;968.293146003418;972.2173650211577;975.3172779054655;975.8682577852005;995.5370752600039;1000.2648053680539;1000.9199264058894;1005.607812952949;1007.2848277722826;984.6356847966226;989.4261328429494;989.4508547755956;998.3361064891839;1000.3947611694892;718.2386670129627;727.6107282603834;728.0571659700701;732.3445516262915;737.4874462248739;14684.265786710728;15177;15229.162396068212;15259.61850953724;15267.847321526864;13119.934400328033;13293.202407855462;13321.001849722523;13381.26403047832;13559.237349108625;10718.892811071868;11153.944230278878;11159.163062770325;11181.608643697431;11439.313641181556;3795.3358162321483;3801.6388443097862;3818.9618103818884;3838.846446142151;3920.6275403836876;52755;52903.47096529024;53355.19967200495;54165.187522187196;54234.186487203115;10528.894711052792;10587;10601.681949541371;10659.893401066045;10726.463676816127;19643.116059777345;19646;19649.705254421195;19684.90157549203;19740.901295493717;7906.130325664172;7970.920290797134;7977.524158030783;8134.877976830352;8240.958795206105;4702.52974702527;4741.739204343794;4752.691075080178;4766.285057241372;4844.176489996709;3360.8655653774063;3366.141633883344;3367.124547617637;3371.4268574342423;3372.3929692655065;569.7208367899782;573.6271423574626;579.5508480927315;580.1935309919215;591.8668299632549;677.6713294052381;679.5616827146562;687.6630451079035;705.1326867952345;705.4215543254585;8440.366972476966;8526.062133165347;8608.698695545625;8617;8753.255973242218;582.7348556406824;618.4063299232697;636.700750647195;691.2707094015861;692.9168499780059;3646.835892384796;3999.6600288975183;4029.7380670256925;4089.345704687236;4095.610916962884;53950.460495394545;58744;58785;58830;58919.41080589139;46380;46442.303365449545;46661;46761.29858052132;47314.290285645744;40809;42201.57798422038;42401.36397954033;47761.52238477571;48316.758416208395;8364.121767214356;8462;8725.607347669496;8773.736787896118;9124.224440922331;35845;36585.45121823228;37134.44298335473;37685.246295074496;38024;45706.31440528461;46679.53320466752;47457.52542474531;47678.52321476879;47982;10952.507137178687;10966.067884229611;11106.111511078932;11186.272892261977;11300.09599232076;12275.69310767238;12336.81494777597;12555.821887152848;12643.87356126427;12895.613131606067;11134.944325278646;11468.94265528667;11570.76858462843;11812.291262524275;12135.211211271238;11336.376499292619;11649.242799218024;11672.766544669228;12013.339266340086;12058.577949771716;10985.231033827555;10996.615118470816;11115.94442027817;11152.107831373633;11547.307161570332;9399.718008459757;9490.525473726148;9888.85166722514;9958.850617240892;10068.24488163376;9885.406875587487;9936.552855121681;10080.294379393372;10144.949275253577;10155.238357123097 06:41:18 INFO - PROCESS | 16489 | __end_tp_report 06:41:18 INFO - PROCESS | 16489 | __start_cc_report 06:41:18 INFO - PROCESS | 16489 | _x_x_mozilla_cycle_collect,352 06:41:18 INFO - PROCESS | 16489 | __end_cc_report 06:41:18 INFO - PROCESS | 16489 | __startTimestamp1465220478245__endTimestamp 06:41:18 INFO - PROCESS | 16489 | 06:41:18 INFO - PROCESS | 16489 | ------- Summary: start ------- 06:41:18 INFO - PROCESS | 16489 | Number of tests: 6 06:41:18 INFO - PROCESS | 16489 | 06:41:18 INFO - PROCESS | 16489 | [#0] dojo.html Cycles:165 Average:5572.28 Median:5778.36 stddev:612.91 (10.6%) stddev-sans-first:589.52 06:41:18 INFO - PROCESS | 16489 | Values: 3351.6 3418.8 3422.2 3426.4 3458.5 5507.5 5556.1 5591.0 5600.0 5603.9 5560.1 5610.0 5612.7 5620.8 5621.9 5065.1 5132.0 5167.4 5183.1 5203.1 4918.3 5049.6 5242.4 5266.5 5286.8 5094.1 5105.5 5114.1 5209.2 5223.5 5168.8 5187.2 5188.7 5210.2 5211.5 4919.6 5000.4 5184.1 5192.0 5231.4 5435.5 5450.4 5458.1 5464.8 5477.9 5999.7 6036.5 6040.7 6048.0 6052.6 5918.3 5995.1 6064.6 6103.5 6115.8 5571.2 5597.9 5600.4 5601.9 5611.1 6099.0 6105.2 6107.8 6117.3 6118.0 5767.1 5847.7 5925.1 5956.2 5977.2 5940.0 5940.7 5942.1 5943.6 5968.7 5819.9 5825.9 5892.3 5903.9 5925.7 5892.8 5983.4 5985.0 5994.2 6027.3 4489.5 4504.9 4529.1 4533.0 4558.7 3997.1 4034.7 4056.7 4084.8 4117.7 5400.5 5446.8 5659.1 5682.0 5722.1 6063.0 6063.8 6067.9 6071.9 6078.4 5553.4 5724.0 5734.8 5746.6 5754.6 5137.0 5173.1 5191.4 5194.0 5215.2 6169.6 6211.1 6233.6 6239.0 6240.2 5905.5 5974.0 6011.8 6022.5 6026.4 6129.1 6151.3 6167.6 6180.8 6182.5 5897.5 5906.7 5910.4 5912.7 5918.6 5861.7 5965.1 5992.5 6032.8 6061.3 5922.1 5930.3 5936.8 5942.4 5950.1 5852.2 5907.1 5938.3 5939.4 5942.1 5577.7 5760.5 5813.1 5822.9 5862.9 5818.8 5858.6 5859.6 5870.7 5872.0 5742.0 5747.3 5749.9 5773.8 5778.4 06:41:18 INFO - PROCESS | 16489 | 06:41:18 INFO - PROCESS | 16489 | [#1] ext.html Cycles:180 Average:58710.34 Median:39378.41 stddev:129082.45 (327.8%) stddev-sans-first:129370.60 06:41:18 INFO - PROCESS | 16489 | Values: 513.2 533.7 540.2 540.4 556.7 31325.8 39888.2 40347.4 40370.0 40388.4 43808.3 44609.3 44704.6 44769.1 44898.1 8775.3 8940.2 8956.4 8970.6 8989.5 8864.3 9009.6 9016.3 9024.4 9028.3 8948.2 9044.2 9045.1 9068.8 9076.7 8871.0 8975.8 8987.2 9045.0 9048.0 8789.6 8909.2 8912.2 8915.8 9152.2 44994.3 45252.0 45315.0 45323.8 45339.3 3477.0 3511.9 3561.1 3643.5 3668.1 32532.2 32838.0 33351.7 33361.2 33556.3 3571.8 3649.2 3665.7 3724.7 3742.8 288666.0 289171.0 289584.0 290192.0 290382.0 45927.3 46754.5 58127.7 58631.4 58717.7 44849.3 44894.6 44940.6 44949.8 45176.8 17087.3 17345.7 17349.7 17350.1 17404.6 13594.7 13761.4 13767.2 13847.9 13853.8 15229.9 15721.8 15820.1 15927.4 15943.9 5975.4 5975.7 6100.6 6137.2 6173.0 1033.3 1035.2 1056.4 1062.5 1140.8 30740.7 30741.0 31010.4 31103.8 31111.0 1122.8 1135.6 1184.8 1214.7 1219.0 15643.5 15755.0 15819.9 16027.9 16031.5 320874.0 644291.0 814477.0 819017.0 828485.0 63173.0 63198.5 63865.0 63887.4 63944.0 1464.1 1469.9 1491.8 1494.4 1535.2 31799.2 31816.0 32247.8 32276.5 32443.4 51288.2 51921.0 51923.0 51963.7 52045.5 306190.0 312373.0 312596.0 313273.0 313617.0 32220.0 32477.0 32812.8 34588.5 35040.8 47346.8 47898.8 48053.3 48383.5 49161.5 38533.4 38949.4 39199.2 39664.6 39744.4 37928.0 39557.6 39814.6 39930.8 40105.4 39980.6 40124.2 40156.8 40220.2 41036.6 34204.0 34933.3 35762.8 35899.3 35914.0 26938.3 27407.2 27434.3 27547.9 27692.9 06:41:18 INFO - PROCESS | 16489 | 06:41:18 INFO - PROCESS | 16489 | [#2] jquery.html Cycles:180 Average:26517.05 Median:2295.66 stddev:73271.86 (3191.8%) stddev-sans-first:73451.10 06:41:18 INFO - PROCESS | 16489 | Values: 367.3 368.8 376.4 378.1 378.8 17648.4 17866.3 18600.0 18605.5 18621.9 18715.5 19230.4 19317.2 19478.9 19501.6 5609.9 5851.9 5872.3 5881.6 5884.3 5654.3 5763.2 5812.8 5853.9 5862.7 5750.5 5751.8 5755.7 5762.3 5763.8 5546.4 5700.5 5711.3 5732.1 5735.7 5098.7 5107.4 5131.9 5132.8 5136.9 22072.7 22102.8 22259.4 22407.6 22650.9 2279.0 2312.3 2441.5 2526.8 3101.8 13846.0 13931.2 14311.4 14349.2 14361.9 1952.6 2009.1 2018.2 2022.8 2038.6 57393.0 62205.0 64148.7 65222.3 69820.7 10617.3 10764.4 11035.2 11053.7 11169.8 15660.3 15751.6 15772.8 15782.1 15803.8 8410.8 8642.6 8677.0 8711.5 8720.0 8496.4 8504.5 8577.5 8599.4 8620.7 4786.3 4859.2 4882.5 4886.7 4914.0 1945.4 1956.9 1981.4 1986.2 2027.2 941.4 943.8 984.7 992.3 1049.3 17840.6 17854.4 17991.7 18273.9 18471.6 992.2 1011.1 1015.5 1050.8 1118.6 10240.5 10429.6 10435.6 10474.7 10537.6 433134.0 434437.0 450050.0 458421.0 459485.0 71761.0 75397.2 78368.0 80660.0 81148.6 1040.6 1041.9 1090.3 1093.8 1102.9 15723.2 15831.1 16172.4 16186.2 16311.7 32716.0 32952.2 33438.0 33570.3 34782.7 48291.8 51482.7 51519.0 51665.5 52079.2 8306.7 8578.7 8611.8 8850.6 8924.2 12434.3 12462.6 12531.9 12710.0 13912.2 11383.5 11534.9 11586.1 11771.8 11838.2 10810.3 11433.7 11473.8 12121.1 12198.9 11104.0 11138.3 11442.1 11461.0 11939.8 8350.5 8359.5 8406.7 8503.4 8527.1 11401.0 11838.6 11892.8 11905.4 12017.5 06:41:18 INFO - PROCESS | 16489 | 06:41:18 INFO - PROCESS | 16489 | [#3] mootools.html Cycles:180 Average:5942.09 Median:5298.52 stddev:3139.76 (59.3%) stddev-sans-first:3131.21 06:41:18 INFO - PROCESS | 16489 | Values: 1549.2 1596.8 1824.1 1854.6 1925.8 7466.9 8176.6 8212.5 8482.1 8520.9 8296.5 8321.7 8368.5 8390.9 8401.2 2386.4 2398.7 2407.7 2413.6 2415.3 2226.1 2240.6 2262.6 2263.2 2266.1 2380.5 2402.1 2408.4 2417.5 2418.6 2410.7 2426.4 2430.7 2435.8 2443.0 2406.9 2412.3 2421.4 2427.0 2437.4 8584.1 8592.4 8613.2 8616.2 8671.0 5231.4 5365.7 5367.7 5375.3 5387.2 3127.2 3162.8 3190.6 3304.2 3377.3 1069.4 1088.2 1089.8 1090.2 1095.0 11981.0 12087.2 12102.7 12103.5 12103.7 4529.2 4565.3 4569.3 4647.4 4666.6 10191.8 10198.1 10199.8 10201.1 10209.2 5373.8 5381.5 5392.7 5393.1 5395.9 4727.9 4808.9 4854.4 4867.0 4899.8 3628.5 3683.3 3704.4 3706.4 3715.6 1071.4 1115.8 1116.8 1119.4 1119.9 1105.8 1162.1 1167.3 1181.5 1183.9 7878.4 7980.2 7994.2 8024.2 8035.2 1212.7 1215.2 1222.5 1236.1 1238.7 6042.7 6115.8 6191.9 6193.0 6198.5 10061.5 10266.5 10286.7 10292.6 10467.2 10147.7 10411.4 10436.3 10584.5 10584.8 8004.6 8081.3 8167.9 8169.8 8216.8 7643.4 7662.9 7732.6 7797.4 7885.8 8680.7 8929.6 9127.9 9206.4 9332.5 9139.8 9186.1 9276.6 9377.8 9586.6 7868.7 8058.5 8098.6 8117.4 8328.0 8122.3 8191.6 8213.3 8261.8 8262.9 6854.1 7231.3 7462.3 7537.6 7567.0 7022.5 7179.7 7181.4 7300.6 7319.6 7340.3 7403.5 7437.6 7479.9 7494.3 6771.5 6843.9 6852.2 6857.6 6894.7 6929.4 6931.3 6967.5 7014.1 7075.4 06:41:18 INFO - PROCESS | 16489 | 06:41:18 INFO - PROCESS | 16489 | [#4] prototype.html Cycles:180 Average:5657.04 Median:6422.00 stddev:1736.50 (27.0%) stddev-sans-first:1694.58 06:41:18 INFO - PROCESS | 16489 | Values: 322.4 342.1 344.2 350.1 352.7 6375.4 6375.7 6406.2 6408.3 6418.6 6329.7 6347.2 6349.9 6350.3 6362.1 4679.8 4765.8 4799.5 4803.7 4898.7 4773.5 4790.2 4795.1 4799.9 4808.3 4727.6 4730.8 4739.9 4747.7 4758.6 4747.7 4747.7 4753.2 4759.0 4762.8 4102.1 4103.2 4103.4 4107.6 4110.4 6032.1 6047.5 6062.8 6068.1 6068.6 5464.8 5600.5 5618.0 5621.1 5650.9 6713.1 6714.6 6726.2 6731.0 6735.5 4646.1 4655.0 4655.0 4656.9 4660.9 6974.7 6986.5 7036.3 7038.8 7048.2 4519.9 4732.1 4739.6 4741.7 4756.8 4708.9 4709.8 4715.7 4718.3 4740.3 5499.7 5514.0 5516.1 5519.9 5531.0 6762.1 6763.3 6767.7 6772.3 6803.8 1686.2 1711.6 1713.9 1713.9 1717.0 1094.1 1117.3 1122.2 1127.2 1140.2 6425.4 6464.8 6482.6 6485.8 6496.8 6953.1 6955.5 6973.8 6976.7 6996.8 6346.4 6444.5 6501.1 6540.5 6554.2 3788.8 3830.5 3833.1 3834.7 3835.1 7277.2 7304.4 7317.9 7327.5 7342.6 7211.7 7225.8 7231.2 7251.8 7260.0 7050.2 7261.4 7313.6 7317.8 7319.6 7035.2 7045.2 7051.5 7059.5 7068.3 6928.9 6948.3 6955.6 6958.1 6961.7 7328.5 7336.5 7342.9 7343.5 7357.7 4787.4 4807.7 4947.5 4948.7 4952.9 6953.8 6963.2 6999.6 7003.4 7021.1 6802.7 6809.0 6822.7 6852.6 6884.8 6851.8 6853.8 6860.0 6862.2 6893.4 6529.4 6628.7 6742.8 6743.8 6748.7 6867.3 6881.8 6882.4 6888.6 6897.2 6725.5 6785.3 6790.0 6790.2 6792.6 06:41:18 INFO - PROCESS | 16489 | 06:41:18 INFO - PROCESS | 16489 | [#5] yui.html Cycles:180 Average:14323.67 Median:42301.47 stddev:16113.53 (38.1%) stddev-sans-first:16126.51 06:41:18 INFO - PROCESS | 16489 | Values: 754.4 814.3 818.8 866.7 883.9 16696.6 16863.0 17044.1 17050.6 17160.3 15587.5 15677.8 15713.6 15720.8 15721.8 933.5 952.6 953.7 959.5 971.6 967.6 968.3 972.2 975.3 975.9 995.5 1000.3 1000.9 1005.6 1007.3 984.6 989.4 989.5 998.3 1000.4 718.2 727.6 728.1 732.3 737.5 14684.3 15177.0 15229.2 15259.6 15267.8 13119.9 13293.2 13321.0 13381.3 13559.2 10718.9 11153.9 11159.2 11181.6 11439.3 3795.3 3801.6 3819.0 3838.8 3920.6 52755.0 52903.5 53355.2 54165.2 54234.2 10528.9 10587.0 10601.7 10659.9 10726.5 19643.1 19646.0 19649.7 19684.9 19740.9 7906.1 7970.9 7977.5 8134.9 8241.0 4702.5 4741.7 4752.7 4766.3 4844.2 3360.9 3366.1 3367.1 3371.4 3372.4 569.7 573.6 579.6 580.2 591.9 677.7 679.6 687.7 705.1 705.4 8440.4 8526.1 8608.7 8617.0 8753.3 582.7 618.4 636.7 691.3 692.9 3646.8 3999.7 4029.7 4089.3 4095.6 53950.5 58744.0 58785.0 58830.0 58919.4 46380.0 46442.3 46661.0 46761.3 47314.3 40809.0 42201.6 42401.4 47761.5 48316.8 8364.1 8462.0 8725.6 8773.7 9124.2 35845.0 36585.5 37134.4 37685.2 38024.0 45706.3 46679.5 47457.5 47678.5 47982.0 10952.5 10966.1 11106.1 11186.3 11300.1 12275.7 12336.8 12555.8 12643.9 12895.6 11134.9 11468.9 11570.8 11812.3 12135.2 11336.4 11649.2 11672.8 12013.3 12058.6 10985.2 10996.6 11115.9 11152.1 11547.3 9399.7 9490.5 9888.9 9958.9 10068.2 9885.4 9936.6 10080.3 10144.9 10155.2 06:41:18 INFO - PROCESS | 16489 | -------- Summary: end -------- 06:41:18 INFO - PROCESS | 16489 | 06:41:18 INFO - TEST-INFO | 16489: exit 0 06:41:18 INFO - TEST-OK | dromaeo_css | took 1108192ms 06:41:18 INFO - TEST-START | kraken 06:41:18 INFO - operating with platform_type : linux_ 06:41:18 INFO - Initialising browser for kraken test... 06:41:18 INFO - TEST-INFO | started process 16735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW7AW8p/profile http://localhost:44848/getInfo.html) 06:41:22 INFO - PROCESS | 16735 | 06:41:22 INFO - PROCESS | 16735 | (process:16815): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:41:22 INFO - PROCESS | 16735 | __metrics Screen width/height:1600/1200 06:41:22 INFO - PROCESS | 16735 | colorDepth:24 06:41:22 INFO - PROCESS | 16735 | Browser inner width/height: 1024/697 06:41:22 INFO - PROCESS | 16735 | __metrics 06:41:23 ERROR - PROCESS | 16735 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:41:24 INFO - TEST-INFO | 16735: exit 0 06:41:24 INFO - Browser initialized. 06:41:24 INFO - Running cycle 1/1 for kraken test... 06:41:24 INFO - TEST-INFO | started process 16865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW7AW8p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:41:25 INFO - PROCESS | 16865 | 06:41:25 INFO - PROCESS | 16865 | (process:16933): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:41:35 INFO - PROCESS | 16865 | RSS: Main: 149848064 06:41:35 INFO - PROCESS | 16865 | 06:41:38 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44848/tests/kraken/driver.html?testName=audio-beat-detection) 06:41:38 INFO - PROCESS | 16865 | RSS: Main: 154812416 06:41:38 INFO - PROCESS | 16865 | 06:41:41 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44848/tests/kraken/driver.html?testName=audio-dft) 06:41:42 INFO - PROCESS | 16865 | RSS: Main: 154816512 06:41:42 INFO - PROCESS | 16865 | 06:41:45 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44848/tests/kraken/driver.html?testName=audio-fft) 06:41:45 INFO - PROCESS | 16865 | RSS: Main: 155021312 06:41:45 INFO - PROCESS | 16865 | 06:41:47 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44848/tests/kraken/driver.html?testName=audio-oscillator) 06:41:48 INFO - PROCESS | 16865 | RSS: Main: 155017216 06:41:48 INFO - PROCESS | 16865 | 06:41:50 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44848/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:51 INFO - PROCESS | 16865 | RSS: Main: 154820608 06:41:51 INFO - PROCESS | 16865 | 06:41:54 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44848/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:54 INFO - PROCESS | 16865 | RSS: Main: 154943488 06:41:54 INFO - PROCESS | 16865 | 06:41:58 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44848/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:58 INFO - PROCESS | 16865 | RSS: Main: 154963968 06:41:58 INFO - PROCESS | 16865 | 06:42:01 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44848/tests/kraken/driver.html?testName=json-parse-financial) 06:42:02 INFO - PROCESS | 16865 | RSS: Main: 155099136 06:42:02 INFO - PROCESS | 16865 | 06:42:03 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44848/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:42:04 INFO - PROCESS | 16865 | RSS: Main: 155828224 06:42:04 INFO - PROCESS | 16865 | 06:42:06 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:42:06 INFO - PROCESS | 16865 | RSS: Main: 155189248 06:42:06 INFO - PROCESS | 16865 | 06:42:08 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:42:09 INFO - PROCESS | 16865 | RSS: Main: 155553792 06:42:09 INFO - PROCESS | 16865 | 06:42:11 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:42:12 INFO - PROCESS | 16865 | RSS: Main: 155619328 06:42:12 INFO - PROCESS | 16865 | 06:42:14 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:42:15 INFO - PROCESS | 16865 | RSS: Main: 155881472 06:42:15 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44848/tests/kraken/driver.html?testName=ai-astar) 06:42:17 INFO - PROCESS | 16865 | RSS: Main: 157224960 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | __start_tp_report 06:42:17 INFO - PROCESS | 16865 | _x_x_mozilla_page_load 06:42:17 INFO - PROCESS | 16865 | _x_x_mozilla_page_load_details 06:42:17 INFO - PROCESS | 16865 | |i|pagename|runs| 06:42:17 INFO - PROCESS | 16865 | |0;ai-astar;113;107;111;110;112;122;111;110;112;110 06:42:17 INFO - PROCESS | 16865 | |1;audio-beat-detection;155;139;167;167;129;156;164;130;169;128 06:42:17 INFO - PROCESS | 16865 | |2;audio-dft;164;161;161;166;161;161;167;166;164;162 06:42:17 INFO - PROCESS | 16865 | |3;audio-fft;76;78;75;159;81;76;77;76;164;75 06:42:17 INFO - PROCESS | 16865 | |4;audio-oscillator;93;94;145;94;92;94;152;93;93;139 06:42:17 INFO - PROCESS | 16865 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;118;119;118 06:42:17 INFO - PROCESS | 16865 | |6;imaging-darkroom;146;146;147;147;146;146;147;146;147;148 06:42:17 INFO - PROCESS | 16865 | |7;imaging-desaturate;96;96;95;96;97;96;96;97;96;96 06:42:17 INFO - PROCESS | 16865 | |8;json-parse-financial;57;54;54;54;63;53;54;54;63;54 06:42:17 INFO - PROCESS | 16865 | |9;json-stringify-tinderbox;65;66;66;66;66;65;66;65;66;66 06:42:17 INFO - PROCESS | 16865 | |10;stanford-crypto-aes;83;77;79;79;79;78;80;81;81;80 06:42:17 INFO - PROCESS | 16865 | |11;stanford-crypto-ccm;118;113;114;111;116;121;129;117;120;118 06:42:17 INFO - PROCESS | 16865 | |12;stanford-crypto-pbkdf2;134;155;144;153;149;137;145;145;146;136 06:42:17 INFO - PROCESS | 16865 | |13;stanford-crypto-sha256-iterative;68;68;68;70;67;65;73;69;67;67 06:42:17 INFO - PROCESS | 16865 | __end_tp_report 06:42:17 INFO - PROCESS | 16865 | __start_cc_report 06:42:17 INFO - PROCESS | 16865 | _x_x_mozilla_cycle_collect,814 06:42:17 INFO - PROCESS | 16865 | __end_cc_report 06:42:17 INFO - PROCESS | 16865 | __startTimestamp1465220537394__endTimestamp 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | ------- Summary: start ------- 06:42:17 INFO - PROCESS | 16865 | Number of tests: 14 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:3.94 (3.5%) stddev-sans-first:4.15 06:42:17 INFO - PROCESS | 16865 | Values: 113.0 107.0 111.0 110.0 112.0 122.0 111.0 110.0 112.0 110.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:160.00 stddev:17.13 (10.7%) stddev-sans-first:18.09 06:42:17 INFO - PROCESS | 16865 | Values: 155.0 139.0 167.0 167.0 129.0 156.0 164.0 130.0 169.0 128.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:2.41 (1.5%) stddev-sans-first:2.54 06:42:17 INFO - PROCESS | 16865 | Values: 164.0 161.0 161.0 166.0 161.0 161.0 167.0 166.0 164.0 162.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:35.80 (47.1%) stddev-sans-first:37.39 06:42:17 INFO - PROCESS | 16865 | Values: 76.0 78.0 75.0 159.0 81.0 76.0 77.0 76.0 164.0 75.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.00 stddev:25.34 (27.2%) stddev-sans-first:26.21 06:42:17 INFO - PROCESS | 16865 | Values: 93.0 94.0 145.0 94.0 92.0 94.0 152.0 93.0 93.0 139.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 06:42:17 INFO - PROCESS | 16865 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 119.0 118.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 06:42:17 INFO - PROCESS | 16865 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 148.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:42:17 INFO - PROCESS | 16865 | Values: 96.0 96.0 95.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:3.83 (7.1%) stddev-sans-first:4.04 06:42:17 INFO - PROCESS | 16865 | Values: 57.0 54.0 54.0 54.0 63.0 53.0 54.0 54.0 63.0 54.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 06:42:17 INFO - PROCESS | 16865 | Values: 65.0 66.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 66.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:1.70 (2.1%) stddev-sans-first:1.32 06:42:17 INFO - PROCESS | 16865 | Values: 83.0 77.0 79.0 79.0 79.0 78.0 80.0 81.0 81.0 80.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:118.00 stddev:5.03 (4.3%) stddev-sans-first:5.34 06:42:17 INFO - PROCESS | 16865 | Values: 118.0 113.0 114.0 111.0 116.0 121.0 129.0 117.0 120.0 118.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:145.50 stddev:7.03 (4.8%) stddev-sans-first:6.37 06:42:17 INFO - PROCESS | 16865 | Values: 134.0 155.0 144.0 153.0 149.0 137.0 145.0 145.0 146.0 136.0 06:42:17 INFO - PROCESS | 16865 | 06:42:17 INFO - PROCESS | 16865 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.15 (3.2%) stddev-sans-first:2.28 06:42:17 INFO - PROCESS | 16865 | Values: 68.0 68.0 68.0 70.0 67.0 65.0 73.0 69.0 67.0 67.0 06:42:17 INFO - PROCESS | 16865 | -------- Summary: end -------- 06:42:17 INFO - PROCESS | 16865 | 06:42:18 INFO - TEST-INFO | 16865: exit 0 06:42:18 INFO - TEST-OK | kraken | took 59433ms 06:42:18 INFO - SUITE-END | took 1167s 06:42:18 INFO - Completed test suite (00:19:27) 06:42:18 INFO - javascript benchmark 06:42:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3351.5978082630086, 3418.846151923164, 3422.195783990763, 3426.3832510148163, 3458.481227815829, 5507.504324610784, 5556.111022236443, 5591.0, 5600.019996500617, 5603.859903502414, 5560.082586373253, 5610.046292130338, 5612.66324020559, 5620.803271885475, 5621.859453513664, 5065.062963351783, 5131.974340128294, 5167.405748338932, 5183.067047931371, 5203.089459344618, 4918.311436398907, 5049.621278404116, 5242.370915490146, 5266.4733526647415, 5286.841394758163, 5094.133997220463, 5105.5149760772665, 5114.079465696173, 5209.192575150839, 5223.477652234784, 5168.767405466744, 5187.247849061865, 5188.662736922088, 5210.218467229945, 5211.478852114796, 4919.581835543983, 5000.449950505442, 5184.144616138333, 5192.039472697563, 5231.424543300234, 5435.537979271767, 5450.3732070811575, 5458.1266997280245, 5464.754086066137, 5477.863053423656, 5999.730012149464, 6036.547258955552, 6040.728167232485, 6047.969760151215, 6052.636841789506, 5918.348981612019, 5995.070764031539, 6064.605800622945, 6103.511719062464, 6115.755369785204, 5571.164325351189, 5597.944020559824, 5600.411956744565, 5601.943980560183, 5611.0741727614895, 6098.969505152446, 6105.175801266772, 6107.786227482017, 6117.265928088658, 6117.969410153009, 5767.077267637158, 5847.707614619252, 5925.140854576062, 5956.225690660186, 5977.193078934375, 5940.0, 5940.732667029994, 5942.078977758368, 5943.613665111754, 5968.731407086691, 5819.923314186889, 5825.912611310834, 5892.292924849045, 5903.881922361528, 5925.674087925119, 5892.764289428461, 5983.37174596661, 5984.970075149684, 5994.190784244159, 6027.306859711101, 4489.483709373464, 4504.932426013613, 4529.139463501924, 4532.9773351133035, 4558.749268790249, 3997.060690737674, 4034.65705415043, 4056.7363121397016, 4084.81618327176, 4117.691173162025, 5400.513953744182, 5446.782128714807, 5659.094544872801, 5682.0, 5722.084466485342, 6063.029915213545, 6063.8484037898525, 6067.908981365283, 6071.878562428727, 6078.392160783975, 5553.389127196006, 5724.026915424388, 5734.799282025193, 5746.597738158289, 5754.625949313281, 5137.049645815536, 5173.094708426086, 5191.428942816287, 5194.039102766001, 5215.217717342429, 6169.629822210592, 6211.068339749074, 6233.594816337014, 6239.0, 6240.188775459252, 5905.527557795452, 5974.0, 6011.819645410645, 6022.518198544019, 6026.427489388501, 6129.14485165794, 6151.292601350723, 6167.599106058092, 6180.783672571439, 6182.505399567934, 5897.498712609477, 5906.7341969612335, 5910.438508341701, 5912.733926973383, 5918.644881307136, 5861.736221869941, 5965.135055417027, 5992.460678538952, 6032.819015429544, 6061.302950160788, 5922.111683247375, 5930.258717660293, 5936.7922122725495, 5942.376050514807, 5950.137230101697, 5852.209951656472, 5907.113932910098, 5938.346781854079, 5939.406059394199, 5942.078977758454, 5577.693226872561, 5760.539156867524, 5813.09896965971, 5822.912656310074, 5862.853428664317, 5818.76724930998, 5858.560607954335, 5859.589828711949, 5870.706464676835, 5872.0, 5742.0, 5747.252857128547, 5749.8562535936935, 5773.826785196451, 5778.364379918122], "unit": "score", "name": "dojo.html", "value": 5532.988963113658}, {"lowerIsBetter": false, "replicates": [513.194284972593, 533.6744585802661, 540.2382640476928, 540.3542766394161, 556.7355506134585, 31325.843370783143, 39888.202235955265, 40347.394789078186, 40370.0, 40388.39417408738, 43808.342874856826, 44609.330860037124, 44704.55295447045, 44769.10461790762, 44898.1020379593, 8775.341849361308, 8940.15068568485, 8956.373053886198, 8970.596323165473, 8989.505577193284, 8864.335174861879, 9009.594568244413, 9016.323775716815, 9024.413413128159, 9028.277737780994, 8948.239399651005, 9044.186023257906, 9045.050269721683, 9068.773280668003, 9076.682316118937, 8871.0, 8975.820483590356, 8987.191152796247, 9045.0, 9047.954760226223, 8789.604467798965, 8909.242714369286, 8912.24245939096, 8915.777105572348, 9152.222061124812, 44994.325085123746, 45252.0, 45315.0, 45323.77338113288, 45339.319910201375, 3476.9826150869335, 3511.8595256189724, 3561.0741207286032, 3643.508126402928, 3668.137987572918, 32532.18669533257, 32838.0, 33351.666483335095, 33361.16597085068, 33556.32887342264, 3571.785692858411, 3649.197176621139, 3665.6700896919406, 3724.7206459515646, 3742.7567208131386, 288666.0, 289171.0, 289584.0, 290192.0, 290382.0, 45927.31109033367, 46754.5324546757, 58127.709361453766, 58631.41368586345, 58717.70641146853, 44849.32726009112, 44894.551054489035, 44940.55059449429, 44949.77525112354, 45176.77411612987, 17087.316507339816, 17345.65308693819, 17349.7397539037, 17350.132493375535, 17404.564885877702, 13594.660133496543, 13761.449542018207, 13767.242801646005, 13847.861521384859, 13853.792193117111, 15229.923850380677, 15721.842781572266, 15820.05079695222, 15927.362905483651, 15943.920280398755, 5975.37258587842, 5975.671338076448, 6100.603460775035, 6137.232845894263, 6172.969135154295, 1033.333499892565, 1035.1615191694752, 1056.4189695667353, 1062.5271754069365, 1140.8363469261308, 30740.69259307423, 30741.0, 31010.379792404026, 31103.844480777905, 31111.0, 1122.7978963786434, 1135.5684839761004, 1184.8222766584909, 1214.678110300771, 1218.975620487603, 15643.452479163174, 15755.0, 15819.920900395424, 16027.919860400856, 16031.519054428385, 320874.0, 644291.0, 814477.0, 819017.0, 828485.0, 63173.0, 63198.47206111704, 63865.0, 63887.36112638907, 63944.0, 1464.0849469081825, 1469.9118052916858, 1491.7986071880157, 1494.3723636072875, 1535.1940231378614, 31799.205019874687, 31816.0, 32247.838760806048, 32276.515852261764, 32443.351132976735, 51288.230676540625, 51921.0, 51923.0, 51963.740181298854, 52045.47954520558, 306190.0, 312373.0, 312596.0, 313273.0, 313617.0, 32220.033398998068, 32477.0, 32812.83593582017, 34588.48117278293, 35040.82479587586, 47346.76326618345, 47898.76050619724, 48053.27920081132, 48383.5161648379, 49161.508384915694, 38533.42199866948, 38949.41575876421, 39199.216015678954, 39664.60335396609, 39744.40383394309, 37928.0, 39557.60442395539, 39814.60185398109, 39930.80034599925, 40105.39841902316, 39980.600193997685, 40124.19751604893, 40156.79921600373, 40220.1955960885, 41036.58963410328, 34204.0, 34933.301333973686, 35762.8211858939, 35899.28201436009, 35914.0, 26938.326541835828, 27407.17778466649, 27434.314142146606, 27547.86226068857, 27692.86153569219], "unit": "score", "name": "ext.html", "value": 19610.875707965934}, {"lowerIsBetter": false, "replicates": [367.30945821854925, 368.8395547936648, 376.4315883016645, 378.11521040764603, 378.7954504567534, 17648.38230661927, 17866.28534858604, 18600.0, 18605.534861628465, 18621.90689046556, 18715.532111697215, 19230.423087307405, 19317.227310907547, 19478.902605486954, 19501.609967800672, 5609.887802243942, 5851.853703657422, 5872.265966754156, 5881.617694849842, 5884.323302820167, 5654.349749778787, 5763.164341170528, 5812.796552120655, 5853.853653658672, 5862.736176872051, 5750.482456578907, 5751.82744517663, 5755.712214389285, 5762.250907382035, 5763.769449222026, 5546.4453554644615, 5700.486956173964, 5711.343195532505, 5732.140178973145, 5735.655860648353, 5098.745062746848, 5107.438181799999, 5131.923021154686, 5132.769025393866, 5136.897262054738, 22072.668909966364, 22102.77897221023, 22259.44351391212, 22407.55184896293, 22650.88674556633, 2279.031411650042, 2312.2947501012186, 2441.523902838947, 2526.835755675894, 3101.7983831051133, 13846.0, 13931.233782141979, 14311.427542898271, 14349.210793406359, 14361.856381436157, 1952.6192392483472, 2009.1461129020254, 2018.1523760020827, 2022.8280596149345, 2038.6330460517102, 57393.0, 62205.0, 64148.679256603886, 65222.347776522576, 69820.6508967457, 10617.256792024484, 10764.3541387517, 11035.172362072877, 11053.723656908642, 11169.776604467865, 15660.295286712126, 15751.606209844616, 15772.842271577367, 15782.131982741059, 15803.841961580467, 8410.78973025667, 8642.611082501302, 8677.045524992245, 8711.477311361212, 8720.0, 8496.362772792065, 8504.53225072627, 8577.528235946958, 8599.355048371397, 8620.741377758677, 4786.2820576913045, 4859.198232291703, 4882.536159064884, 4886.706797592155, 4914.0, 1945.4260993007097, 1956.9217231310872, 1981.4253866378588, 1986.2154448992567, 2027.1891243502423, 941.4445477168366, 943.7593413679605, 984.7144328144758, 992.3351354592296, 1049.3231865446896, 17840.643187136186, 17854.37509687181, 17991.73012404815, 18273.90863045676, 18471.630567388846, 992.2161492421051, 1011.1203253169789, 1015.5480811039164, 1050.8423736439595, 1118.625260537729, 10240.539175737109, 10429.634962776267, 10435.582576697, 10474.68575942723, 10537.587499256362, 433134.0, 434437.0, 450050.0, 458421.0, 459485.0, 71761.0, 75397.24602754012, 78368.0, 80660.0, 81148.59425702952, 1040.5837664934088, 1041.9374837509774, 1090.3022065878004, 1093.7703082352637, 1102.9393383363831, 15723.213839308217, 15831.129287889276, 16172.353105876104, 16186.190690465664, 16311.67376652484, 32716.0, 32952.176195595304, 33438.0, 33570.32859342849, 34782.65217347794, 48291.75854120707, 51482.742586288325, 51519.0, 51665.48334516607, 52079.218811717095, 8306.70926517569, 8578.742637720628, 8611.82776344482, 8850.557472126497, 8924.152205540722, 12434.253944763343, 12462.563810266598, 12531.93734031324, 12709.989836790875, 13912.234827084607, 11383.54465821358, 11534.884651153381, 11586.073114151017, 11771.823422648838, 11838.230515016496, 10810.29733067348, 11433.714157146138, 11473.82789258145, 12121.090918180995, 12198.878011219775, 11104.0, 11138.27601205919, 11442.141839362248, 11461.0, 11939.761204775683, 8350.540720260202, 8359.498430094214, 8406.705765298186, 8503.447275927045, 8527.062023177321, 11401.0, 11838.585649502225, 11892.76214475723, 11905.40472976365, 12017.519299227934], "unit": "score", "name": "jquery.html", "value": 9081.812640632053}, {"lowerIsBetter": false, "replicates": [1549.2253873063469, 1596.7525033619786, 1824.1426529531125, 1854.5919897622518, 1925.846919093496, 7466.925330746691, 8176.632051557679, 8212.548309842956, 8482.066972633005, 8520.872186917193, 8296.543690097042, 8321.667133314675, 8368.539730314831, 8390.874136887951, 8401.201885820838, 2386.439186791107, 2398.724146723123, 2407.6990376202975, 2413.6017557103055, 2415.3478560788576, 2226.0984301357894, 2240.5854916840435, 2262.6492893601517, 2263.1852533088077, 2266.1275408967585, 2380.5476959377747, 2402.1112188490283, 2408.446057406789, 2417.528581926525, 2418.625113107471, 2410.6625072489865, 2426.3934016495878, 2430.732619411863, 2435.7929575985972, 2442.9511409771794, 2406.9037238510437, 2412.3245491262473, 2421.418859473731, 2426.9514609707885, 2437.4150203951103, 8584.098669639661, 8592.355573331963, 8613.181747733955, 8616.224539791387, 8670.956645216796, 5231.398389185254, 5365.651232669903, 5367.704776237305, 5375.274337964363, 5387.164989426645, 3127.233827712202, 3162.826044567548, 3190.6490286068515, 3304.157439852846, 3377.3245350929665, 1069.3904474449566, 1088.2219213262556, 1089.7929393415225, 1090.2150451674781, 1094.9610961512742, 11980.999999999913, 12087.153899227058, 12102.697432564168, 12103.515859365614, 12103.697407564881, 4529.162105010583, 4565.269556870885, 4569.314602809539, 4647.419072615923, 4666.580007799246, 10191.847122293171, 10198.082172604501, 10199.796004080024, 10201.081902628799, 10209.234307426972, 5373.7581808818695, 5381.461853814665, 5392.703401312887, 5393.1370980642905, 5395.865103372368, 4727.858164255078, 4808.903821923542, 4854.393200849894, 4867.0, 4899.755012249373, 3628.546431696038, 3683.336999340091, 3704.370257056253, 3706.425504046877, 3715.6098609646137, 1071.3625392891217, 1115.7712668902855, 1116.815725405299, 1119.367557330106, 1119.8544189255344, 1105.8230683090828, 1162.1167912386477, 1167.287954347847, 1181.480148734554, 1183.8520184976878, 7878.409119316074, 7980.162082981319, 7994.160613135653, 8024.2376974187355, 8035.236652518001, 1212.721074152932, 1215.2161855603088, 1222.4560070768423, 1236.0729452910318, 1238.6779437346354, 6042.728077236535, 6115.84710382244, 6191.907121393183, 6193.040078787795, 6198.504119670415, 10061.54723037465, 10266.538005789758, 10286.742831429274, 10292.639757608447, 10467.162626989822, 10147.695569132939, 10411.427371494488, 10436.269461137648, 10584.470776461147, 10584.788304233873, 8004.63979120941, 8081.272685458454, 8167.918320816834, 8169.836603268021, 8216.808562758366, 7643.350315223268, 7662.923370766221, 7732.574708391093, 7797.376209903081, 7885.763427097197, 8680.652773888974, 8929.642814287616, 9127.863082053907, 9206.355555111346, 9332.533373331442, 9139.77150571241, 9186.127317904788, 9276.582553784961, 9377.765555860886, 9586.568604412958, 7868.685252589832, 8058.476199047043, 8098.635561399869, 8117.391195660467, 8328.042275138436, 8122.309603683753, 8191.590420478833, 8213.3429325655, 8261.793455163668, 8262.925819643408, 6854.074699915647, 7231.349178573953, 7462.328390444886, 7537.585432801248, 7567.0, 7022.473314501331, 7179.748708795167, 7181.35367816899, 7300.598467084362, 7319.560826350436, 7340.302671246223, 7403.51877127985, 7437.553746774995, 7479.88780168287, 7494.288042635941, 6771.52599318043, 6843.931560684528, 6852.246252912275, 6857.622830744357, 6894.724211031503, 6929.411000065051, 6931.341522555349, 6967.512274140761, 7014.123234595676, 7075.433965282662], "unit": "score", "name": "mootools.html", "value": 4837.2516372846485}, {"lowerIsBetter": false, "replicates": [322.3922905323466, 342.1292809799061, 344.1550992313869, 350.13341978602944, 352.70725298002645, 6375.362463753628, 6375.744970201198, 6406.231252249725, 6408.295087540367, 6418.582792118509, 6329.651869147195, 6347.17486726726, 6349.904751428732, 6350.301466838644, 6362.109304697335, 4679.789409476564, 4765.809367625308, 4799.472058073609, 4803.663743537953, 4898.7060776353355, 4773.5226477352335, 4790.209615413452, 4795.0889331027165, 4799.928001079987, 4808.254720518308, 4727.550882666142, 4730.787114579835, 4739.928901066487, 4747.667663263573, 4758.643101767364, 4747.667663263573, 4747.691400058985, 4753.215719406294, 4759.048190361907, 4762.78567464465, 4102.056526998807, 4103.199876024177, 4103.4460347852955, 4107.589241075869, 4110.445089912853, 6032.125341825411, 6047.485963693091, 6062.757489700451, 6068.120122582201, 6068.6358818471035, 5464.754086066137, 5600.467955544217, 5618.0449323614675, 5621.100623900156, 5650.915236271459, 6713.12729345182, 6714.563553369016, 6726.192856857208, 6730.966345168243, 6735.461163106988, 4646.140464014168, 4655.022445286494, 4655.045715628288, 4656.859069527954, 4660.86017419478, 6974.686139123752, 6986.54587451819, 7036.261192574808, 7038.753643622448, 7048.18945821232, 4519.909601807945, 4732.124556956974, 4739.620830333565, 4741.715497070118, 4756.8097276108565, 4708.882277943078, 4709.764511774466, 4715.717056976524, 4718.268668356411, 4740.312654665123, 5499.697516636624, 5513.972430137824, 5516.062269414209, 5519.889602207933, 5531.004419204502, 6762.053312536249, 6763.323667633295, 6767.729290828312, 6772.288909664513, 6803.795886123424, 1686.1822016322074, 1711.5806627376123, 1713.8628909687195, 1713.9143042847809, 1717.029878118859, 1094.0973696700255, 1117.3240189685287, 1122.2256642916361, 1127.2391135983178, 1140.1961617059953, 6425.421712045938, 6464.773732919325, 6482.611043337415, 6485.77299794505, 6496.837579060561, 6953.061336719579, 6955.513114082067, 6973.825654358681, 6976.720931162697, 6996.790096297017, 6346.428821406095, 6444.484441244689, 6501.0898474213645, 6540.509461790385, 6554.246261679872, 3788.8484460621817, 3830.5211848518934, 3833.0609000794984, 3834.69322454203, 3835.0987517933263, 7277.2358902315555, 7304.415646748247, 7317.890231646529, 7327.523710958771, 7342.596157211405, 7211.711531538785, 7225.819354516179, 7231.16841563227, 7251.8187045324285, 7260.0, 7050.189228238715, 7261.41908647307, 7313.561186328838, 7317.780466586118, 7319.560826350329, 7035.155781306072, 7045.225025247321, 7051.5063945523325, 7059.54112982675, 7068.29317068289, 6928.896066558905, 6948.305169483011, 6955.617441040589, 6958.06066181059, 6961.721531138698, 7328.450366222448, 7336.486445948733, 7342.853142937004, 7343.48595598303, 7357.668904899399, 4787.3776409066595, 4807.663463557517, 4947.455779864284, 4948.678335908298, 4952.851414457572, 6953.826154346182, 6963.2340442552295, 6999.61502117368, 7003.404710599452, 7021.087258656342, 6802.693878775566, 6808.9659551701925, 6822.727090916308, 6852.554583952027, 6884.827879303058, 6851.828704282433, 6853.828654283683, 6860.0, 6862.176538815374, 6893.379595836399, 6529.444997175104, 6628.734850605922, 6742.786298466323, 6743.7639682612835, 6748.662566871735, 6867.3476019778045, 6881.793546193622, 6882.414994725505, 6888.552244104118, 6897.206821215424, 6725.461963042847, 6785.321467853175, 6789.966050169717, 6790.185177778698, 6792.626405547742], "unit": "score", "name": "prototype.html", "value": 5086.098812926489}, {"lowerIsBetter": false, "replicates": [754.4492520460066, 814.2956342763512, 818.8444195602835, 866.6879923227641, 883.8674198870173, 16696.582585435353, 16863.0, 17044.0625765583, 17050.573735656613, 17160.313587456487, 15587.53237402877, 15677.84322156778, 15713.607159821011, 15720.84279157208, 15721.764173537378, 933.5332333833084, 952.6332362040595, 953.7138858342504, 959.4866746290701, 971.616211596419, 967.6226271754022, 968.293146003418, 972.2173650211577, 975.3172779054655, 975.8682577852005, 995.5370752600039, 1000.2648053680539, 1000.9199264058894, 1005.607812952949, 1007.2848277722826, 984.6356847966226, 989.4261328429494, 989.4508547755956, 998.3361064891839, 1000.3947611694892, 718.2386670129627, 727.6107282603834, 728.0571659700701, 732.3445516262915, 737.4874462248739, 14684.265786710728, 15177.0, 15229.162396068212, 15259.61850953724, 15267.847321526864, 13119.934400328033, 13293.202407855462, 13321.001849722523, 13381.26403047832, 13559.237349108625, 10718.892811071868, 11153.944230278878, 11159.163062770325, 11181.608643697431, 11439.313641181556, 3795.3358162321483, 3801.6388443097862, 3818.9618103818884, 3838.846446142151, 3920.6275403836876, 52755.0, 52903.47096529024, 53355.19967200495, 54165.187522187196, 54234.186487203115, 10528.894711052792, 10587.0, 10601.681949541371, 10659.893401066045, 10726.463676816127, 19643.116059777345, 19646.0, 19649.705254421195, 19684.90157549203, 19740.901295493717, 7906.130325664172, 7970.920290797134, 7977.524158030783, 8134.877976830352, 8240.958795206105, 4702.52974702527, 4741.739204343794, 4752.691075080178, 4766.285057241372, 4844.176489996709, 3360.8655653774063, 3366.141633883344, 3367.124547617637, 3371.4268574342423, 3372.3929692655065, 569.7208367899782, 573.6271423574626, 579.5508480927315, 580.1935309919215, 591.8668299632549, 677.6713294052381, 679.5616827146562, 687.6630451079035, 705.1326867952345, 705.4215543254585, 8440.366972476966, 8526.062133165347, 8608.698695545625, 8617.0, 8753.255973242218, 582.7348556406824, 618.4063299232697, 636.700750647195, 691.2707094015861, 692.9168499780059, 3646.835892384796, 3999.6600288975183, 4029.7380670256925, 4089.345704687236, 4095.610916962884, 53950.460495394545, 58744.0, 58785.0, 58830.0, 58919.41080589139, 46380.0, 46442.303365449545, 46661.0, 46761.29858052132, 47314.290285645744, 40809.0, 42201.57798422038, 42401.36397954033, 47761.52238477571, 48316.758416208395, 8364.121767214356, 8462.0, 8725.607347669496, 8773.736787896118, 9124.224440922331, 35845.0, 36585.45121823228, 37134.44298335473, 37685.246295074496, 38024.0, 45706.31440528461, 46679.53320466752, 47457.52542474531, 47678.52321476879, 47982.0, 10952.507137178687, 10966.067884229611, 11106.111511078932, 11186.272892261977, 11300.09599232076, 12275.69310767238, 12336.81494777597, 12555.821887152848, 12643.87356126427, 12895.613131606067, 11134.944325278646, 11468.94265528667, 11570.76858462843, 11812.291262524275, 12135.211211271238, 11336.376499292619, 11649.242799218024, 11672.766544669228, 12013.339266340086, 12058.577949771716, 10985.231033827555, 10996.615118470816, 11115.94442027817, 11152.107831373633, 11547.307161570332, 9399.718008459757, 9490.525473726148, 9888.85166722514, 9958.850617240892, 10068.24488163376, 9885.406875587487, 9936.552855121681, 10080.294379393372, 10144.949275253577, 10155.238357123097], "unit": "score", "name": "yui.html", "value": 6721.591300982927}], "name": "dromaeo_css", "value": 7390.72019126554}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 111.0, 110.0, 112.0, 122.0, 111.0, 110.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [155.0, 139.0, 167.0, 167.0, 129.0, 156.0, 164.0, 130.0, 169.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 161.0, 166.0, 161.0, 161.0, 167.0, 166.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 75.0, 159.0, 81.0, 76.0, 77.0, 76.0, 164.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 145.0, 94.0, 92.0, 94.0, 152.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 54.0, 54.0, 63.0, 53.0, 54.0, 54.0, 63.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [83.0, 77.0, 79.0, 79.0, 79.0, 78.0, 80.0, 81.0, 81.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [118.0, 113.0, 114.0, 111.0, 116.0, 121.0, 129.0, 117.0, 120.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [134.0, 155.0, 144.0, 153.0, 149.0, 137.0, 145.0, 145.0, 146.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 70.0, 67.0, 65.0, 73.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1520.1000000000004}]} 06:42:18 INFO - Return code: 0 06:42:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:42:18 ERROR - # TBPL SUCCESS # 06:42:18 INFO - Running post-action listener: _resource_record_post_action 06:42:18 INFO - Running post-run listener: _resource_record_post_run 06:42:19 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 16384; Write bytes: 461750272; Read time: 28; Write time: 268828 06:42:19 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237821952; Read time: 0; Write time: 179600 06:42:19 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 16384; Write bytes: 223928320; Read time: 28; Write time: 89228 06:42:19 INFO - Running post-run listener: _upload_blobber_files 06:42:19 INFO - Blob upload gear active. 06:42:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:42:19 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 06:42:19 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:42:19 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:42:20 INFO - (blobuploader) - INFO - Open directory for files ... 06:42:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:42:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:42:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:21 INFO - (blobuploader) - INFO - Done attempting. 06:42:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:42:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:42:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:42:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:42:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:42:21 INFO - (blobuploader) - INFO - Done attempting. 06:42:21 INFO - (blobuploader) - INFO - Iteration through files over. 06:42:21 INFO - Return code: 0 06:42:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:42:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:42:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/706282053dbba9e20711f765f8ea0db0c5b22b074e9fc83ba4382c699ccf054301c85f9bfb6e53e9b0728e03c26ea4b3132d14fb28244532160e5657a9120193", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7234e658db18b7f8b8fe0f6364427adbb739676edf11b5db2d8d9243548c5b0eef186384a66f53222850420fa1d6ff2420e9247be3e14e0eb0266e978634541"} 06:42:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:42:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:42:21 INFO - Contents: 06:42:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/706282053dbba9e20711f765f8ea0db0c5b22b074e9fc83ba4382c699ccf054301c85f9bfb6e53e9b0728e03c26ea4b3132d14fb28244532160e5657a9120193", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7234e658db18b7f8b8fe0f6364427adbb739676edf11b5db2d8d9243548c5b0eef186384a66f53222850420fa1d6ff2420e9247be3e14e0eb0266e978634541"} 06:42:21 INFO - Running post-run listener: copy_logs_to_upload_dir 06:42:21 INFO - Copying logs to upload dir... 06:42:21 INFO - mkdir: /builds/slave/test/build/upload/logs 06:42:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.684433 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-06 06:42:20.155652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:20.160144) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013 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-Beta/sha512/706282053dbba9e20711f765f8ea0db0c5b22b074e9fc83ba4382c699ccf054301c85f9bfb6e53e9b0728e03c26ea4b3132d14fb28244532160e5657a9120193", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7234e658db18b7f8b8fe0f6364427adbb739676edf11b5db2d8d9243548c5b0eef186384a66f53222850420fa1d6ff2420e9247be3e14e0eb0266e978634541"} build_url:https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/706282053dbba9e20711f765f8ea0db0c5b22b074e9fc83ba4382c699ccf054301c85f9bfb6e53e9b0728e03c26ea4b3132d14fb28244532160e5657a9120193", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7234e658db18b7f8b8fe0f6364427adbb739676edf11b5db2d8d9243548c5b0eef186384a66f53222850420fa1d6ff2420e9247be3e14e0eb0266e978634541"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:20.190051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:20.190405) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465219085.591400-574871013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:42:20.275514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:42:20.278906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:42:20.279234) ========= ========= Total master_lag: 0.20 =========