builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1461327735.52 results: success (0) buildid: 20160422030645 builduid: 5ea98b9a5e0d4c0ca9cdc63d3aa73f95 revision: dc62a0f70e53975f1ddbfe09933072736571a44d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:15.522940) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:15.523445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:15.523721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:15.536449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:15.536796) ========= 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=33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 05:22:16-- 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% 45.2M=0s 2016-04-22 05:22:16 (45.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112959 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:15.661275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:15.661588) ========= 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=33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016741 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:15.711265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:15.711657) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dc62a0f70e53975f1ddbfe09933072736571a44d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dc62a0f70e53975f1ddbfe09933072736571a44d --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=33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 05:22:16,223 truncating revision to first 12 chars 2016-04-22 05:22:16,223 Setting DEBUG logging. 2016-04-22 05:22:16,223 attempt 1/10 2016-04-22 05:22:16,223 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dc62a0f70e53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 05:22:16,820 unpacking tar archive at: mozilla-aurora-dc62a0f70e53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.879572 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:16.606326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:16.606690) ========= script_repo_revision: dc62a0f70e53975f1ddbfe09933072736571a44d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:16.607104) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:16.607373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:22:16.793214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-22 05:22:16.793619) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:22:17 INFO - MultiFileLogger online at 20160422 05:22:17 in /builds/slave/test 05:22:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:22:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:22:17 INFO - {'append_to_log': False, 05:22:17 INFO - 'base_work_dir': '/builds/slave/test', 05:22:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:22:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:22:17 INFO - 'branch': 'Mozilla-Aurora', 05:22:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:22:17 INFO - 'config_files': ('talos/linux_config.py',), 05:22:17 INFO - 'default_actions': ('clobber', 05:22:17 INFO - 'read-buildbot-config', 05:22:17 INFO - 'download-and-extract', 05:22:17 INFO - 'populate-webroot', 05:22:17 INFO - 'create-virtualenv', 05:22:17 INFO - 'install', 05:22:17 INFO - 'run-tests'), 05:22:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:22:17 INFO - 'download_minidump_stackwalk': True, 05:22:17 INFO - 'download_symbols': 'ondemand', 05:22:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:22:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:22:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:22:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:22:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:22:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:22:17 INFO - 'installer_path': 'installer.exe', 05:22:17 INFO - 'log_level': 'info', 05:22:17 INFO - 'log_name': 'talos', 05:22:17 INFO - 'log_to_console': True, 05:22:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:22:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:22:17 INFO - 'opt_config_files': (), 05:22:17 INFO - 'pip_index': False, 05:22:17 INFO - 'sps_profile': False, 05:22:17 INFO - 'sps_profile_interval': 0, 05:22:17 INFO - 'suite': 'dromaeojs-e10s', 05:22:17 INFO - 'system_bits': '32', 05:22:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:22:17 INFO - 'title': 'talos-linux64-ix-063', 05:22:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:22:17 INFO - 'use_talos_json': True, 05:22:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:22:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:22:17 INFO - 'work_dir': 'build'} 05:22:17 INFO - ##### 05:22:17 INFO - ##### Running clobber step. 05:22:17 INFO - ##### 05:22:17 INFO - Running pre-action listener: _resource_record_pre_action 05:22:17 INFO - Running main action method: clobber 05:22:17 INFO - rmtree: /builds/slave/test/build 05:22:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:22:17 INFO - Running post-action listener: _resource_record_post_action 05:22:17 INFO - ##### 05:22:17 INFO - ##### Running read-buildbot-config step. 05:22:17 INFO - ##### 05:22:17 INFO - Running pre-action listener: _resource_record_pre_action 05:22:17 INFO - Running main action method: read_buildbot_config 05:22:17 INFO - Using buildbot properties: 05:22:17 INFO - { 05:22:17 INFO - "project": "", 05:22:17 INFO - "product": "firefox", 05:22:17 INFO - "script_repo_revision": "production", 05:22:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:22:17 INFO - "repository": "", 05:22:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:22:17 INFO - "buildid": "20160422030645", 05:22:17 INFO - "pgo_build": "True", 05:22:17 INFO - "basedir": "/builds/slave/test", 05:22:17 INFO - "buildnumber": 231, 05:22:17 INFO - "slavename": "talos-linux64-ix-063", 05:22:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:22:17 INFO - "platform": "ubuntu64_hw", 05:22:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:22:17 INFO - "branch": "mozilla-aurora", 05:22:17 INFO - "repo_path": "releases/mozilla-aurora", 05:22:17 INFO - "revision": "dc62a0f70e53975f1ddbfe09933072736571a44d", 05:22:17 INFO - "stage_platform": "linux64-pgo", 05:22:17 INFO - "builduid": "5ea98b9a5e0d4c0ca9cdc63d3aa73f95", 05:22:17 INFO - "slavebuilddir": "test" 05:22:17 INFO - } 05:22:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 05:22:17 INFO - Running post-action listener: _resource_record_post_action 05:22:17 INFO - ##### 05:22:17 INFO - ##### Running download-and-extract step. 05:22:17 INFO - ##### 05:22:17 INFO - Running pre-action listener: _resource_record_pre_action 05:22:17 INFO - Running main action method: download_and_extract 05:22:17 INFO - mkdir: /builds/slave/test/build/tests 05: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')]} 05:22:17 INFO - https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:22:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:22:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:22:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:22:18 INFO - Downloaded 1448 bytes. 05:22:18 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:22:18 INFO - Using the following test package requirements: 05:22:18 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:22:18 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:22:18 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:22:18 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'jsshell-linux-x86_64.zip'], 05:22:18 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:22:18 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:22:18 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:22:18 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:22:18 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:22:18 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:22:18 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:22:18 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:22:18 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')]} 05:22:18 INFO - https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:22:19 INFO - Downloaded 23358478 bytes. 05:22:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:22:21 INFO - Return code: 0 05:22:21 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:22:21 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')]} 05:22:21 INFO - https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:22:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:22:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:22:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:22:22 INFO - Downloaded 23358478 bytes. 05:22:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:22:23 INFO - Return code: 0 05: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')]} 05:22:23 INFO - https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:22:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:22:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:22:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:22:24 INFO - Downloaded 10845198 bytes. 05:22:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:22:25 INFO - Return code: 0 05:22:25 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')]} 05:22:25 INFO - https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:22:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:22:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:22:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:22:26 INFO - Downloaded 60842122 bytes. 05:22:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:22:26 INFO - mkdir: /builds/slave/test/properties 05:22:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:22:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:22:26 INFO - Contents: 05:22:26 INFO - build_url:https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:22:27 INFO - Running post-action listener: _resource_record_post_action 05:22:27 INFO - Running post-action listener: set_extra_try_arguments 05:22:27 INFO - ##### 05:22:27 INFO - ##### Running populate-webroot step. 05:22:27 INFO - ##### 05:22:27 INFO - Running pre-action listener: _resource_record_pre_action 05:22:27 INFO - Running main action method: populate_webroot 05:22:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:27 INFO - '--tppagecycles', 05:22:27 INFO - '7'], 05:22:27 INFO - 'tests': ['tsvgm']}}, 05:22:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:22:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:22:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:22:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:22:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:27 INFO - 'talos_options': ['--e10s'], 05:22:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:27 INFO - 'tests': ['damp', 'tps']}, 05:22:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:27 INFO - 'talos_options': ['--e10s'], 05:22:27 INFO - 'tests': ['damp', 'tps']}, 05:22:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:22:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:22:27 INFO - 'other': {'tests': ['a11yr', 05:22:27 INFO - 'ts_paint', 05:22:27 INFO - 'tpaint', 05:22:27 INFO - 'sessionrestore', 05:22:27 INFO - 'sessionrestore_no_auto_restore', 05:22:27 INFO - 'tabpaint']}, 05:22:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:22:27 INFO - 'tests': ['a11yr', 05:22:27 INFO - 'ts_paint', 05:22:27 INFO - 'tpaint', 05:22:27 INFO - 'sessionrestore', 05:22:27 INFO - 'sessionrestore_no_auto_restore', 05:22:27 INFO - 'tabpaint']}, 05:22:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:22:27 INFO - 'tests': ['a11yr', 05:22:27 INFO - 'ts_paint', 05:22:27 INFO - 'tpaint', 05:22:27 INFO - 'sessionrestore', 05:22:27 INFO - 'sessionrestore_no_auto_restore', 05:22:27 INFO - 'tabpaint']}, 05:22:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:22:27 INFO - 'tests': ['a11yr', 05:22:27 INFO - 'ts_paint', 05:22:27 INFO - 'tpaint', 05:22:27 INFO - 'sessionrestore', 05:22:27 INFO - 'sessionrestore_no_auto_restore', 05:22:27 INFO - 'tabpaint']}, 05:22:27 INFO - 'other_l64': {'tests': ['a11yr', 05:22:27 INFO - 'ts_paint', 05:22:27 INFO - 'tpaint', 05:22:27 INFO - 'sessionrestore', 05:22:27 INFO - 'sessionrestore_no_auto_restore', 05:22:27 INFO - 'tabpaint']}, 05:22:27 INFO - 'other_nol64': {'tests': ['a11yr', 05:22:27 INFO - 'ts_paint', 05:22:27 INFO - 'tpaint', 05:22:27 INFO - 'sessionrestore', 05:22:27 INFO - 'sessionrestore_no_auto_restore', 05:22:27 INFO - 'tabpaint']}, 05:22:27 INFO - 'svgr': {'tests': ['tsvgx', 05:22:27 INFO - 'tsvgr_opacity', 05:22:27 INFO - 'tart', 05:22:27 INFO - 'tscrollx', 05:22:27 INFO - 'cart']}, 05:22:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:22:27 INFO - 'tests': ['tsvgx', 05:22:27 INFO - 'tsvgr_opacity', 05:22:27 INFO - 'tart', 05:22:27 INFO - 'tscrollx', 05:22:27 INFO - 'cart']}, 05:22:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:27 INFO - 'tests': ['tp5o']}, 05:22:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:27 INFO - 'talos_options': ['--e10s'], 05:22:27 INFO - 'tests': ['tp5o']}, 05:22:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:27 INFO - 'talos_options': ['--xperf_path', 05:22:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:27 INFO - 'tests': ['tp5n']}, 05:22:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:27 INFO - 'talos_options': ['--e10s', 05:22:27 INFO - '--xperf_path', 05:22:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:27 INFO - 'tests': ['tp5n']}}, 05:22:27 INFO - 'talos.zip': {'path': '', 05:22:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:27 INFO - Running post-action listener: _resource_record_post_action 05:22:27 INFO - ##### 05:22:27 INFO - ##### Running create-virtualenv step. 05:22:27 INFO - ##### 05:22:27 INFO - Running pre-action listener: _resource_record_pre_action 05:22:27 INFO - Running main action method: create_virtualenv 05:22:27 INFO - Creating virtualenv /builds/slave/test/build/venv 05:22:27 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 05:22:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:22:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:27 INFO - Using real prefix '/usr' 05:22:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:22:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:29 INFO - Installing pip.................done. 05:22:29 INFO - Return code: 0 05:22:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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 0x7fae61549f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, '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': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', '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 05:22:29 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 05:22:29 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 05:22:29 INFO - Using env: {'DISPLAY': ':0', 05:22:29 INFO - 'HOME': '/home/cltbld', 05:22:29 INFO - 'LANG': 'en_US.UTF-8', 05:22:29 INFO - 'LANGUAGE': 'en_US:en', 05:22:29 INFO - 'LOGNAME': 'cltbld', 05:22:29 INFO - 'MAIL': '/var/mail/cltbld', 05:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:29 INFO - 'MOZ_NO_REMOTE': '1', 05:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:29 INFO - 'NO_EM_RESTART': '1', 05:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:29 INFO - 'PWD': '/builds/slave/test', 05:22:29 INFO - 'SHELL': '/bin/bash', 05:22:29 INFO - 'SHLVL': '1', 05:22:29 INFO - 'TERM': 'linux', 05:22:29 INFO - 'TMOUT': '86400', 05:22:29 INFO - 'USER': 'cltbld', 05:22:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:29 INFO - '_': '/tools/buildbot/bin/python'} 05:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:29 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 05:22:29 INFO - Cleaning up... 05:22:29 INFO - Return code: 0 05:22:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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 0x7fae61549f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, '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': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', '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 05:22:29 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 05:22:29 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 05:22:29 INFO - Using env: {'DISPLAY': ':0', 05:22:29 INFO - 'HOME': '/home/cltbld', 05:22:29 INFO - 'LANG': 'en_US.UTF-8', 05:22:29 INFO - 'LANGUAGE': 'en_US:en', 05:22:29 INFO - 'LOGNAME': 'cltbld', 05:22:29 INFO - 'MAIL': '/var/mail/cltbld', 05:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:29 INFO - 'MOZ_NO_REMOTE': '1', 05:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:29 INFO - 'NO_EM_RESTART': '1', 05:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:29 INFO - 'PWD': '/builds/slave/test', 05:22:29 INFO - 'SHELL': '/bin/bash', 05:22:29 INFO - 'SHLVL': '1', 05:22:29 INFO - 'TERM': 'linux', 05:22:29 INFO - 'TMOUT': '86400', 05:22:29 INFO - 'USER': 'cltbld', 05:22:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:29 INFO - '_': '/tools/buildbot/bin/python'} 05:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:30 INFO - Downloading/unpacking psutil>=0.7.1 05:22:30 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 05:22:30 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 05:22:30 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 05:22:30 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 05:22:30 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 05:22:30 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 05:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:32 INFO - Installing collected packages: psutil 05:22:32 INFO - Running setup.py install for psutil 05:22:32 INFO - building 'psutil._psutil_linux' extension 05:22:32 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 05:22:32 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 05:22:32 INFO - building 'psutil._psutil_posix' extension 05:22:32 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 05:22:32 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 05:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:32 INFO - Successfully installed psutil 05:22:32 INFO - Cleaning up... 05:22:32 INFO - Return code: 0 05:22:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:32 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 0x7fae61549f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, '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': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', '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 05:22:32 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 05:22:32 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 05:22:32 INFO - Using env: {'DISPLAY': ':0', 05:22:32 INFO - 'HOME': '/home/cltbld', 05:22:32 INFO - 'LANG': 'en_US.UTF-8', 05:22:32 INFO - 'LANGUAGE': 'en_US:en', 05:22:32 INFO - 'LOGNAME': 'cltbld', 05:22:32 INFO - 'MAIL': '/var/mail/cltbld', 05:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:32 INFO - 'MOZ_NO_REMOTE': '1', 05:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:32 INFO - 'NO_EM_RESTART': '1', 05:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:32 INFO - 'PWD': '/builds/slave/test', 05:22:32 INFO - 'SHELL': '/bin/bash', 05:22:32 INFO - 'SHLVL': '1', 05:22:32 INFO - 'TERM': 'linux', 05:22:32 INFO - 'TMOUT': '86400', 05:22:32 INFO - 'USER': 'cltbld', 05:22:32 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:32 INFO - '_': '/tools/buildbot/bin/python'} 05:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05: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 05: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 05: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 05: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 05: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 05: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 05:22:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:22:34 INFO - Installing collected packages: mozsystemmonitor 05:22:34 INFO - Running setup.py install for mozsystemmonitor 05:22:34 INFO - Successfully installed mozsystemmonitor 05:22:34 INFO - Cleaning up... 05:22:34 INFO - Return code: 0 05:22:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:22:34 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')]} 05:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:34 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')]} 05:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:34 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 0x7fae61549f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, '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': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', '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 05:22:34 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 05:22:34 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 05:22:34 INFO - Using env: {'DISPLAY': ':0', 05:22:34 INFO - 'HOME': '/home/cltbld', 05:22:34 INFO - 'LANG': 'en_US.UTF-8', 05:22:34 INFO - 'LANGUAGE': 'en_US:en', 05:22:34 INFO - 'LOGNAME': 'cltbld', 05:22:34 INFO - 'MAIL': '/var/mail/cltbld', 05:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:34 INFO - 'MOZ_NO_REMOTE': '1', 05:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:34 INFO - 'NO_EM_RESTART': '1', 05:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:34 INFO - 'PWD': '/builds/slave/test', 05:22:34 INFO - 'SHELL': '/bin/bash', 05:22:34 INFO - 'SHLVL': '1', 05:22:34 INFO - 'TERM': 'linux', 05:22:34 INFO - 'TMOUT': '86400', 05:22:34 INFO - 'USER': 'cltbld', 05:22:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:34 INFO - '_': '/tools/buildbot/bin/python'} 05:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:35 INFO - Downloading/unpacking blobuploader==1.2.4 05: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 05: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 05: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 05: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 05: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 05: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 05:22:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:22:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:22:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:37 INFO - Downloading docopt-0.6.1.tar.gz 05:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:22:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:22:37 INFO - Running setup.py install for blobuploader 05:22:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:22:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:22:37 INFO - Running setup.py install for requests 05:22:38 INFO - Running setup.py install for docopt 05:22:38 INFO - Successfully installed blobuploader requests docopt 05:22:38 INFO - Cleaning up... 05:22:38 INFO - Return code: 0 05:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:38 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 0x7fae61549f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, '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': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', '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 05:22:38 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 05:22:38 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 05:22:38 INFO - Using env: {'DISPLAY': ':0', 05:22:38 INFO - 'HOME': '/home/cltbld', 05:22:38 INFO - 'LANG': 'en_US.UTF-8', 05:22:38 INFO - 'LANGUAGE': 'en_US:en', 05:22:38 INFO - 'LOGNAME': 'cltbld', 05:22:38 INFO - 'MAIL': '/var/mail/cltbld', 05:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:38 INFO - 'MOZ_NO_REMOTE': '1', 05:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:38 INFO - 'NO_EM_RESTART': '1', 05:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:38 INFO - 'PWD': '/builds/slave/test', 05:22:38 INFO - 'SHELL': '/bin/bash', 05:22:38 INFO - 'SHLVL': '1', 05:22:38 INFO - 'TERM': 'linux', 05:22:38 INFO - 'TMOUT': '86400', 05:22:38 INFO - 'USER': 'cltbld', 05:22:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:38 INFO - '_': '/tools/buildbot/bin/python'} 05:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:38 INFO - Running setup.py (path:/tmp/pip-OwmfAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:38 INFO - Running setup.py (path:/tmp/pip-pfQlKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:38 INFO - Running setup.py (path:/tmp/pip-glfbvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:38 INFO - Running setup.py (path:/tmp/pip-vzQVde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:38 INFO - Running setup.py (path:/tmp/pip-vAZ1Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:38 INFO - Running setup.py (path:/tmp/pip-RshX7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:39 INFO - Running setup.py (path:/tmp/pip-fuJfHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:39 INFO - Running setup.py (path:/tmp/pip-F6oY1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:39 INFO - Running setup.py (path:/tmp/pip-cSIke3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:39 INFO - Running setup.py (path:/tmp/pip-qqfOgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:39 INFO - Running setup.py (path:/tmp/pip-RPpgFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:39 INFO - Running setup.py (path:/tmp/pip-vzAkXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:39 INFO - Running setup.py (path:/tmp/pip-2Xlr3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:39 INFO - Running setup.py (path:/tmp/pip-bziE7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:39 INFO - Running setup.py (path:/tmp/pip-A86rD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:39 INFO - Running setup.py (path:/tmp/pip-1289g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:39 INFO - Running setup.py (path:/tmp/pip-0IGpz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:22:39 INFO - Running setup.py install for manifestparser 05:22:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:22:39 INFO - Running setup.py install for mozcrash 05:22:40 INFO - Running setup.py install for mozdebug 05:22:40 INFO - Running setup.py install for mozdevice 05:22:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Running setup.py install for mozfile 05:22:40 INFO - Running setup.py install for mozhttpd 05:22:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Running setup.py install for mozinfo 05:22:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Running setup.py install for mozInstall 05:22:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Running setup.py install for mozleak 05:22:40 INFO - Running setup.py install for mozlog 05:22:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Running setup.py install for moznetwork 05:22:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:22:40 INFO - Running setup.py install for mozprocess 05:22:41 INFO - Running setup.py install for mozprofile 05:22:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:22:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:22:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:22:41 INFO - Running setup.py install for mozrunner 05:22:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:22:41 INFO - Running setup.py install for mozscreenshot 05:22:41 INFO - Running setup.py install for moztest 05:22:41 INFO - Running setup.py install for mozversion 05:22:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:22:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:22:41 INFO - Cleaning up... 05:22:41 INFO - Return code: 0 05:22:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:41 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 0x7fae61549f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, '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': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', '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 05:22:41 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 05:22:41 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 05:22:41 INFO - Using env: {'DISPLAY': ':0', 05:22:41 INFO - 'HOME': '/home/cltbld', 05:22:41 INFO - 'LANG': 'en_US.UTF-8', 05:22:41 INFO - 'LANGUAGE': 'en_US:en', 05:22:41 INFO - 'LOGNAME': 'cltbld', 05:22:41 INFO - 'MAIL': '/var/mail/cltbld', 05:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:41 INFO - 'MOZ_NO_REMOTE': '1', 05:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:41 INFO - 'NO_EM_RESTART': '1', 05:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:41 INFO - 'PWD': '/builds/slave/test', 05:22:41 INFO - 'SHELL': '/bin/bash', 05:22:41 INFO - 'SHLVL': '1', 05:22:41 INFO - 'TERM': 'linux', 05:22:41 INFO - 'TMOUT': '86400', 05:22:41 INFO - 'USER': 'cltbld', 05:22:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:41 INFO - '_': '/tools/buildbot/bin/python'} 05:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:41 INFO - Running setup.py (path:/tmp/pip-djT8KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:41 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)) 05:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:41 INFO - Running setup.py (path:/tmp/pip-8_kqJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:42 INFO - Running setup.py (path:/tmp/pip-QvuGT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:42 INFO - Running setup.py (path:/tmp/pip-vYakVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:42 INFO - Running setup.py (path:/tmp/pip-vn9STB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:42 INFO - Running setup.py (path:/tmp/pip-LNJRKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:42 INFO - Running setup.py (path:/tmp/pip-OR9LG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:42 INFO - Running setup.py (path:/tmp/pip-Zv99bK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:42 INFO - Running setup.py (path:/tmp/pip-2UlZi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:42 INFO - Running setup.py (path:/tmp/pip-u3aMMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:42 INFO - Running setup.py (path:/tmp/pip-pxUD3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:42 INFO - Running setup.py (path:/tmp/pip-GhTydz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:42 INFO - Running setup.py (path:/tmp/pip-_8ge_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:42 INFO - Running setup.py (path:/tmp/pip-kZPlry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:42 INFO - Running setup.py (path:/tmp/pip-jGvgHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:42 INFO - Running setup.py (path:/tmp/pip-F0xNqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:43 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)) 05:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:43 INFO - Running setup.py (path:/tmp/pip-BLNyk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:43 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)) 05:22:43 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)) 05:22:43 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)) 05:22:43 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)) 05:22:43 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)) 05:22:43 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)) 05:22:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:44 INFO - Downloading blessings-1.6.tar.gz 05:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:22:45 INFO - Installing collected packages: blessings 05:22:45 INFO - Running setup.py install for blessings 05:22:45 INFO - Successfully installed blessings 05:22:45 INFO - Cleaning up... 05:22:45 INFO - Return code: 0 05:22:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:45 INFO - Reading from file tmpfile_stdout 05:22:45 INFO - Current package versions: 05:22:45 INFO - argparse == 1.2.1 05:22:45 INFO - blessings == 1.6 05:22:45 INFO - blobuploader == 1.2.4 05:22:45 INFO - docopt == 0.6.1 05:22:45 INFO - manifestparser == 1.1 05:22:45 INFO - mozInstall == 1.12 05:22:45 INFO - mozcrash == 0.17 05:22:45 INFO - mozdebug == 0.1 05:22:45 INFO - mozdevice == 0.48 05:22:45 INFO - mozfile == 1.2 05:22:45 INFO - mozhttpd == 0.7 05:22:45 INFO - mozinfo == 0.9 05:22:45 INFO - mozleak == 0.1 05:22:45 INFO - mozlog == 3.1 05:22:45 INFO - moznetwork == 0.27 05:22:45 INFO - mozprocess == 0.22 05:22:45 INFO - mozprofile == 0.28 05:22:45 INFO - mozrunner == 6.11 05:22:45 INFO - mozscreenshot == 0.1 05:22:45 INFO - mozsystemmonitor == 0.0 05:22:45 INFO - moztest == 0.7 05:22:45 INFO - mozversion == 1.4 05:22:45 INFO - psutil == 3.1.1 05:22:45 INFO - requests == 1.2.3 05:22:45 INFO - wsgiref == 0.1.2 05:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:45 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 0x7fae61549f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, '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': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', '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 05:22:45 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 05:22:45 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 05:22:45 INFO - Using env: {'DISPLAY': ':0', 05:22:45 INFO - 'HOME': '/home/cltbld', 05:22:45 INFO - 'LANG': 'en_US.UTF-8', 05:22:45 INFO - 'LANGUAGE': 'en_US:en', 05:22:45 INFO - 'LOGNAME': 'cltbld', 05:22:45 INFO - 'MAIL': '/var/mail/cltbld', 05:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:45 INFO - 'MOZ_NO_REMOTE': '1', 05:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:45 INFO - 'NO_EM_RESTART': '1', 05:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:45 INFO - 'PWD': '/builds/slave/test', 05:22:45 INFO - 'SHELL': '/bin/bash', 05:22:45 INFO - 'SHLVL': '1', 05:22:45 INFO - 'TERM': 'linux', 05:22:45 INFO - 'TMOUT': '86400', 05:22:45 INFO - 'USER': 'cltbld', 05:22:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:45 INFO - '_': '/tools/buildbot/bin/python'} 05:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 INFO - Cleaning up... 05:22:45 INFO - Return code: 0 05:22:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:45 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 0x7fae61549f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, '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': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', '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 05:22:45 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 05:22:45 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 05:22:45 INFO - Using env: {'DISPLAY': ':0', 05:22:45 INFO - 'HOME': '/home/cltbld', 05:22:45 INFO - 'LANG': 'en_US.UTF-8', 05:22:45 INFO - 'LANGUAGE': 'en_US:en', 05:22:45 INFO - 'LOGNAME': 'cltbld', 05:22:45 INFO - 'MAIL': '/var/mail/cltbld', 05:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:45 INFO - 'MOZ_NO_REMOTE': '1', 05:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:45 INFO - 'NO_EM_RESTART': '1', 05:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:45 INFO - 'PWD': '/builds/slave/test', 05:22:45 INFO - 'SHELL': '/bin/bash', 05:22:45 INFO - 'SHLVL': '1', 05:22:45 INFO - 'TERM': 'linux', 05:22:45 INFO - 'TMOUT': '86400', 05:22:45 INFO - 'USER': 'cltbld', 05:22:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:45 INFO - '_': '/tools/buildbot/bin/python'} 05:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:45 INFO - Downloading/unpacking jsonschema 05:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:22:47 INFO - Downloading/unpacking functools32 (from jsonschema) 05:22:47 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 05:22:47 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 05:22:47 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 05:22:47 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 05:22:47 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 05:22:47 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 05:22:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:22:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:22:48 INFO - warning: no files found matching '*.txt' 05:22:48 INFO - no previously-included directories found matching 'build' 05:22:48 INFO - no previously-included directories found matching 'dist' 05:22:48 INFO - no previously-included directories found matching '.git*' 05:22:48 INFO - Installing collected packages: jsonschema, functools32 05:22:48 INFO - Running setup.py install for functools32 05:22:48 INFO - warning: no files found matching '*.txt' 05:22:48 INFO - no previously-included directories found matching 'build' 05:22:48 INFO - no previously-included directories found matching 'dist' 05:22:48 INFO - no previously-included directories found matching '.git*' 05:22:48 INFO - Successfully installed jsonschema functools32 05:22:48 INFO - Cleaning up... 05:22:48 INFO - Return code: 0 05:22:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:48 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 0x7fae61549f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, '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': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', '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 05:22:48 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 05:22:48 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 05:22:48 INFO - Using env: {'DISPLAY': ':0', 05:22:48 INFO - 'HOME': '/home/cltbld', 05:22:48 INFO - 'LANG': 'en_US.UTF-8', 05:22:48 INFO - 'LANGUAGE': 'en_US:en', 05:22:48 INFO - 'LOGNAME': 'cltbld', 05:22:48 INFO - 'MAIL': '/var/mail/cltbld', 05:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:48 INFO - 'MOZ_NO_REMOTE': '1', 05:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:48 INFO - 'NO_EM_RESTART': '1', 05:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:48 INFO - 'PWD': '/builds/slave/test', 05:22:48 INFO - 'SHELL': '/bin/bash', 05:22:48 INFO - 'SHLVL': '1', 05:22:48 INFO - 'TERM': 'linux', 05:22:48 INFO - 'TMOUT': '86400', 05:22:48 INFO - 'USER': 'cltbld', 05:22:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:48 INFO - '_': '/tools/buildbot/bin/python'} 05:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:48 INFO - Downloading/unpacking flake8 05:22:48 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 05:22:48 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 05:22:48 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 05:22:48 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 05:22:48 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 05:22:48 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 05:22:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:22:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:22:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:22:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:51 INFO - no previously-included directories found matching 'docs/_build' 05:22:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:22:51 INFO - Running setup.py install for pep8 05:22:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:51 INFO - no previously-included directories found matching 'docs/_build' 05:22:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:22:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:22:51 INFO - Cleaning up... 05:22:51 INFO - Return code: 0 05:22:51 INFO - Running post-action listener: _resource_record_post_action 05:22:51 INFO - Running post-action listener: _start_resource_monitoring 05:22:51 INFO - Starting resource monitoring. 05:22:51 INFO - ##### 05:22:51 INFO - ##### Running install step. 05:22:51 INFO - ##### 05:22:51 INFO - Running pre-action listener: _resource_record_pre_action 05:22:51 INFO - Running main action method: install 05:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:51 INFO - Reading from file tmpfile_stdout 05:22:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:22:51 INFO - Reading from file tmpfile_stdout 05:22:51 INFO - Output received: 05:22:51 INFO - Usage: mozinstall [options] installer 05:22:51 INFO - Options: 05:22:51 INFO - -h, --help show this help message and exit 05:22:51 INFO - -d DEST, --destination=DEST 05:22:51 INFO - Directory to install application into. [default: 05:22:51 INFO - "/builds/slave/test"] 05:22:51 INFO - --app=APP Application being installed. [default: firefox] 05:22:51 INFO - mkdir: /builds/slave/test/build/application 05:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:23:07 INFO - Reading from file tmpfile_stdout 05:23:07 INFO - Output received: 05:23:07 INFO - /builds/slave/test/build/application/firefox/firefox 05:23:07 INFO - Running post-action listener: _resource_record_post_action 05:23:07 INFO - ##### 05:23:07 INFO - ##### Running run-tests step. 05:23:07 INFO - ##### 05:23:07 INFO - Running pre-action listener: _resource_record_pre_action 05:23:07 INFO - Running main action method: run_tests 05:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:23:07 INFO - Python 2.7.3 05:23:07 INFO - Return code: 0 05:23:07 INFO - grabbing minidump binary from tooltool 05:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:07 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 0x1b48160>, '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 0x1b49060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b494f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:23:07 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 05:23:07 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 05:23:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:23:07 INFO - Return code: 0 05:23:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:23:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:23:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:23:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:23:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:23:08 INFO - Return code: 0 05:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 05:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 05:23:08 INFO - Using env: {'DISPLAY': ':0', 05:23:08 INFO - 'HOME': '/home/cltbld', 05:23:08 INFO - 'LANG': 'en_US.UTF-8', 05:23:08 INFO - 'LANGUAGE': 'en_US:en', 05:23:08 INFO - 'LOGNAME': 'cltbld', 05:23:08 INFO - 'MAIL': '/var/mail/cltbld', 05:23:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:23:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:08 INFO - 'MOZ_NO_REMOTE': '1', 05:23:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:08 INFO - 'NO_EM_RESTART': '1', 05:23:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:08 INFO - 'PWD': '/builds/slave/test', 05:23:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:23:08 INFO - 'SHELL': '/bin/bash', 05:23:08 INFO - 'SHLVL': '1', 05:23:08 INFO - 'TERM': 'linux', 05:23:08 INFO - 'TMOUT': '86400', 05:23:08 INFO - 'USER': 'cltbld', 05:23:08 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423', 05:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:08 INFO - '_': '/tools/buildbot/bin/python'} 05:23:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 05:23:08 INFO - mozversion application_buildid: 20160422030645 05:23:08 INFO - mozversion application_changeset: dc62a0f70e53975f1ddbfe09933072736571a44d 05:23:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:23:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:08 INFO - mozversion application_name: Firefox 05:23:08 INFO - mozversion application_remotingname: firefox-dev 05:23:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:23:08 INFO - mozversion application_vendor: Mozilla 05:23:08 INFO - mozversion application_version: 47.0a2 05:23:08 INFO - mozversion platform_buildid: 20160422030645 05:23:08 INFO - mozversion platform_changeset: dc62a0f70e53975f1ddbfe09933072736571a44d 05:23:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:23:08 INFO - mozversion platform_version: 47.0a2 05:23:08 INFO - using testdate: 1461327788 05:23:08 INFO - actual date: 1461327788 05:23:08 INFO - starting webserver on 'localhost:35744' 05:23:08 INFO - SUITE-START | Running 2 tests 05:23:08 INFO - TEST-START | dromaeo_css 05:23:08 INFO - operating with platform_type : linux_ 05:23:08 INFO - Initialising browser for dromaeo_css test... 05:23:08 INFO - TEST-INFO | started process 1213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD_1wXH/profile http://localhost:35744/getInfo.html) 05:23:12 INFO - PROCESS | 1213 | 05:23:12 INFO - PROCESS | 1213 | (process:1302): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:23:13 INFO - PROCESS | 1213 | __metrics Screen width/height:1600/1200 05:23:13 INFO - PROCESS | 1213 | colorDepth:24 05:23:13 INFO - PROCESS | 1213 | Browser inner width/height: 1024/697 05:23:13 INFO - PROCESS | 1213 | __metrics 05:23:14 ERROR - PROCESS | 1213 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:23:14 INFO - TEST-INFO | 1213: exit 0 05:23:14 INFO - Browser initialized. 05:23:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:23:14 INFO - TEST-INFO | started process 1353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD_1wXH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:16 INFO - PROCESS | 1353 | 05:23:16 INFO - PROCESS | 1353 | (process:1426): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:23:26 INFO - PROCESS | 1353 | RSS: Main: 150745088 05:23:26 INFO - PROCESS | 1353 | 05:24:16 INFO - PROCESS | 1353 | 1461327856346 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] 05:26:24 INFO - PROCESS | 1353 | Cycle 1(1): loaded http://localhost:35744/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35744/tests/dromaeo/cssquery-ext.html) 05:26:25 INFO - PROCESS | 1353 | RSS: Main: 156037120 05:26:25 INFO - PROCESS | 1353 | 05:29:27 INFO - PROCESS | 1353 | Cycle 1(1): loaded http://localhost:35744/tests/dromaeo/cssquery-ext.html (next: http://localhost:35744/tests/dromaeo/cssquery-jquery.html) 05:29:27 INFO - PROCESS | 1353 | RSS: Main: 153718784 05:29:27 INFO - PROCESS | 1353 | 05:32:29 INFO - PROCESS | 1353 | Cycle 1(1): loaded http://localhost:35744/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35744/tests/dromaeo/cssquery-mootools.html) 05:32:29 INFO - PROCESS | 1353 | RSS: Main: 153530368 05:32:29 INFO - PROCESS | 1353 | 05:35:31 INFO - PROCESS | 1353 | Cycle 1(1): loaded http://localhost:35744/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35744/tests/dromaeo/cssquery-prototype.html) 05:35:32 INFO - PROCESS | 1353 | RSS: Main: 152846336 05:35:32 INFO - PROCESS | 1353 | 05:38:34 INFO - PROCESS | 1353 | Cycle 1(1): loaded http://localhost:35744/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35744/tests/dromaeo/cssquery-yui.html) 05:38:34 INFO - PROCESS | 1353 | RSS: Main: 154234880 05:38:34 INFO - PROCESS | 1353 | 05:41:37 INFO - PROCESS | 1353 | Cycle 1(1): loaded http://localhost:35744/tests/dromaeo/cssquery-yui.html (next: http://localhost:35744/tests/dromaeo/cssquery-dojo.html) 05:41:37 INFO - PROCESS | 1353 | RSS: Main: 155803648 05:41:37 INFO - PROCESS | 1353 | 05:41:37 INFO - PROCESS | 1353 | __start_tp_report 05:41:37 INFO - PROCESS | 1353 | _x_x_mozilla_page_load 05:41:37 INFO - PROCESS | 1353 | _x_x_mozilla_page_load_details 05:41:37 INFO - PROCESS | 1353 | |i|pagename|runs| 05:41:37 INFO - PROCESS | 1353 | |0;dojo.html;3258.934821303574;3320.950185747214;3358.983205083974;3391.067456449476;3396.966030339696;5491.28613280273;5502.972485137574;5520.150794363165;5533.6679799212025;5560.499555040045;5480.862978425532;5510.090835012228;5526.613137080406;5555.555555555556;5556.444355564441;5046.369203849528;5060.342155519796;5131.640785145041;5137.717425541612;5147.613928955325;4883.19427294496;5023.673461225008;5118.820841270556;5147.356580427447;5184.066867963765;5058.494150584949;5065.341505604266;5137.255098010786;5145.253938178962;5168;5139.7687104080405;5157.30376399185;5175.922361164586;5182.196759502245;5208.270842082112;4884.877878053042;4891.339669144655;5026;5071;5119.206522988943;5325.680459172462;5326.387465441485;5351.117065684196;5359.9732001340135;5392.40683524812;5748.16651585522;5872.442117998783;5907.350191478934;5917.349091599964;5938.168656388109;5939.227900372967;5987.491063259628;6024.939750602482;6028.0957856321465;6042.667653279068;5563.721813909288;5578.888422231573;5595.048841696921;5601.5238704709745;5602.4957753802355;5822.243108395882;6036.728347224298;6071.150038994544;6079.6960151992225;6108.3280839107665;5831.3877042910735;5863;5863.853403664943;5866.70666466675;5896.734646940898;5904.61619994699;5910.7931222407005;5936.168936348915;5943.197668314809;5956.791512297049;5675.943240567624;5887.852803679856;5896.3219229788265;5901.940980590225;5981.5214782817275;5824.883502330014;5880.323762767251;5883.705814709333;5884.029135192731;5915.792947246911;4510.120526497301;4510.481294651091;4513.751743654065;4517.706349087299;4521.796519156645;4030.536488303824;4034.455348527911;4054.412110243998;4095.365218391154;4107.835686572504;5492.588055895823;5709.257796486513;5732.168835518826;5749.9425005750245;5816.680082595498;6001.969990150022;6022.36765139654;6022.518198544106;6025.548083893726;6026.578139530278;5517.531009864127;5669.518090962314;5745.68398738065;5762.884742305214;5785.681787501644;5129.692218466904;5148.30497882781;5150.459201783834;5169.948300517022;5176.50823171798;6234.064890266496;6253.843653908598;6254.781082662085;6256.843578910472;6269.247690277105;5804.622699524517;5905.173275741314;5915.556333274935;5988.520918326611;6030.005049166838;6165.445109940127;6169.105479705508;6169.167162433194;6171;6205.627662340274;5667.263255776723;5915.70421478933;5921.940780592139;5922.526197904243;5932.347441781314;5974.731137098928;5990.580659353977;6011.549133814894;6054.485368743706;6059.182010428536;5745.080787074048;5774.682392468455;5801.535877129904;5818.4763371296785;5820.650760954356;5614.326280846324;5747.8563035924435;5796.275465566804;5818.2436283282905;5829.737661805144;5744.396838331915;5800.651960882192;5802.564807639528;5819.738111785065;5866.911996320144;5852.326982397079;5855.882882342415;5879.676617786063;5888.587798854211;5898.498627616701;5555.8888822224135;5743.224664670216;5744.942550574441;5751;5756.42435756421 05:41:37 INFO - PROCESS | 1353 | |1;ext.html;514.1901505129422;559.1026402623786;567.690608618303;570.9657420554767;614.1156734302604;38714.806425967865;39444.80277598608;39475.802620986855;39505.60494395055;39513.20973580526;43595.56404435955;44275.11449771011;44340;44354.11291774162;44367.556324436744;8807.647694092244;9030.68392606259;9037.960634527015;9046.276297896185;9048.909510904905;8776.956115219415;8919.866202006975;8933.330000249975;8940.374173807835;8946.418482798597;9016.549172541347;9154.084591540859;9156.862647060267;9157.587908544132;9160.633574657006;9029.367944243906;9074.818503629891;9093.272538196994;9095.863562046574;9107.544622768835;8967.730968070968;9127.17855393011;9141.314401419853;9159.542022898895;9186.724398268063;44366.77816610896;44454;44773;44842.77578612086;44924.55075449236;3502.369573476773;3680.392735198689;3711.4432835074685;3715.851365945359;3762.698984081267;32524;32716;32896;32993.67006329954;33245.16887077843;4270.551592082848;4290.957090429087;4297.05464797744;4410.206162890679;4430.446194225722;293331;293758;294240;297521;299901.99999999785;45652;46084;46414.07171856544;57027;57285.14072288919;44287.335689964675;44428.3335749964;44529.33206001913;44600;44653.55346446559;16606.75089873653;16839.831601684073;16882.831171688373;16926.57683557921;16954.915225423792;13818.37817298224;13873.236971966639;13919.582412527641;13962.930185349009;14021.369038393093;15576.610584735472;15690.450834220976;15716.764248536281;15755.291011904492;15837;5806.912896306559;5999.490043346277;6067.029275315928;6087.178230938766;6156.5998210117095;1028.953697083633;1100.8128618134936;1127.143371038017;1148.9482973266222;1157.946482216201;30310.242243943638;30701.385972280877;31235.375292494024;31357.686423135932;31618.841905790323;1094.3215206571817;1137.374444055766;1177.664365655784;1213.7329787446747;1284.4926254129566;15800.288986995383;16515.091669958267;17162.914185428992;17207.13964301805;17609.911950440164;420672;861412;882291;885508;890525;57907.71046144827;58446;58527;58605;58799;1474.565003324022;1509.2680050175657;1517.658526831454;1556.9844301557066;1562.7733978573272;29286.41427171487;30497.237569060064;30944;31027.985065302397;33183.834080830406;51583;52214.73892630512;52243.21635175552;52243.47756522538;52300.21549676834;275427;275654;277694;278519;279771;35516;35608.109797255274;36646.816765916;36722;36809.89570312895;47628;47935.28097078617;48162.59187040564;49305.26042109443;49571;40165;40258.396124058745;40259.19481610293;41497.37753933754;42459;39369.60630393659;40915.181696366504;40938.795306023276;41003.58996409998;41401.1719765609;39391.212175755754;39512.60487395204;39966.600333996284;40217;40335.596644034355;35638.465423019195;35812.82093589516;35993;36028.639713602526;36071.27857442784;27192.864035679693;27782.5832612515;27810.16569502918;27988;28014.299642508286 05:41:37 INFO - PROCESS | 1353 | |2;jquery.html;382.42826973674363;392.57993946477274;397.126322091399;398;402.4446264155465;17422.651546969068;19943.700844487343;20244.696329555067;20254.08856601453;20263.290784822533;18316.633667326645;18358.173882175302;18677.626447471077;19107.61784764304;19114.044297785123;5634.352049514297;5775.797847075353;5786;5807.680577568232;5833.970830145843;4404;6224.875502489947;6475.999999999976;6480.611163330215;6521.869562608745;5960.761569537213;6424.614523128604;6426.325235850239;6439.098526206335;6456.644884531373;6175.69121543921;6180.969095154518;6181.629102253879;6197.225346831646;6215.627062376249;5514.172874068881;5515.448455154453;5547.278853748987;5568.972155139239;5573.136163894603;14225.78661320081;14260.572182834532;14528.636784080376;14737.70524589513;14744.852551474456;2271.931842044741;2331.1491305673308;2514.962275565868;2709.986450067757;2957.4972254716536;9584.233261339075;9699.757506062335;9815.067568580973;9847.655332063343;10199.4390308533;1615.8707303415815;1620.0684606351394;1628.861546768526;1655.7102507061215;1683.1163639089455;65428.67285663589;67679.66160169168;68291.65854170747;68774;69211;10477.895221047693;10480.266381353233;10582.735431614272;10612.097971672494;10846.511906964206;14970.925145374204;15134.394624215129;15145.394184232728;15206.619834504005;15245.6188595286;8287.62705678246;8333.541655209021;8347.916520834713;8552.828943421096;8612.397132200811;8332.750017499484;8362;8386.329093672492;8507.82984340322;8517.95741021291;4626.444826620827;4646.86059418218;4664.720116793003;4677.64917631179;4764.071006153767;1959.2358979997812;2012.2655230840637;2013.3154727392757;2029.046348216336;2060.268604645329;953.2945620240972;970.898055704155;1012.3875055591409;1071.4589132488043;1088.4938503595865;17504.387346442814;17626.383076592258;17642.911785440992;17785.46643600694;18273.543161421072;976.6191185437685;1020.5764607687875;1087.7245360003917;1092.9344239345664;1117.5250518529592;9955.153811926068;10318.896811031944;10349.172066234834;10353.378797272188;10369.585216591402;330737;337708;444762;449798;450224;71491.28508714847;73382.2661773386;73495.63252183705;74725;76020;470.0786458541229;486.9780859861315;489.40048440659905;490.36742602042966;500.2870908954725;11238.943805280922;11462.197646164688;11735.354555499189;11737.35444550558;11838.289702617525;30670;36348;36438.63561364352;36483.81758091299;37059.444108337855;51064.23403649023;51600;51821.7408912953;52301.7384913073;52538;7802.180771018961;8723.389362744547;8728.69449569262;8844.071372506052;8911.955440222757;12571.18287311322;12795.552155674506;12921.612351629467;13024;13215.735685286432;5527.226188333556;8092.554909480035;10986.615468458565;11238.494267758135;11304.43477826089;11254.324740515594;11600.767984640092;11616.709582260512;11829.645110646694;12011.939940300243;11587.768244634892;11603.187776855539;11715.882841171479;11802.704932376759;12096.455659495168;8661.566921654017;8760.649574016968;8767.079456656958;8777.824443511221;9000.954995224982;11470.197086203885;11474.311541307548;11495.655130346104;11540.480678369662;11622.360770157722 05:41:37 INFO - PROCESS | 1353 | |3;mootools.html;1581.5571639940817;1602.575317540852;1826.3151318255655;1949.941501754948;1988.7215789789432;7312.890306645405;8366.2470377666;8597.785055373612;8785;8811.647534098636;8494.78763030923;8566.057733649293;8570.785730356743;8617.181367770052;8625.396222264444;2394.3056513611077;2403.495265994143;2412.662227288181;2415.1184817541557;2423.9757602424015;2394.1022116706235;2414.4808866093786;2424.284835973392;2434.3427274635837;2448.742881997391;2384.618461046233;2387.785099341059;2418.9637155442683;2420.0319872051145;2427.2232885476656;2364.4561750797325;2368.4197371643886;2378.203301893868;2380.309710184053;2425.9029638814427;2402.9639555406684;2408.7832095111526;2432.3311089450367;2443.2548072837776;2448.7306396296394;8656.783580410478;8717;8741.737747867573;8764;8826.955865220698;5122.334096567422;5218.843434696965;5266.15741481365;5266.315379000744;5281.947180528184;3186.776925615208;3198.552202691625;3233.757468189872;3233.951490727641;3284.950725739116;1031.9019693129142;2068;2122.3632910127053;2138.1447421031557;2140.8180304673965;11725;11735.061195104456;11744.412779360997;11801.173917825756;11848.703782405422;4396.494403143615;4481.1709833680225;4482.843100491467;4514.68397212192;4516.932246016312;9467.289953253534;9479;9494.05059494045;9547.809043819223;9630.2777291702;5160;5216.478352164829;5225.973870130625;5237.895242095136;5238.083335416287;4740.312654665055;4789.760511974388;4836.540528649773;4859.246816743411;4865.635077369211;3805.162864169878;3854.7879866607045;3869.071422858494;3886.145048089416;3927.8625248116177;1188.5780547905542;1193.2244041373176;1204.747003129335;1207.8610959739567;1212.678640160358;1467.523055007127;1468.324570697491;1477.4016523307862;1489.0842132088687;1512.8033355663692;8398.79003024917;8439.156084391634;8444.113368096385;8447.831043379098;8451.366147538836;572.7937942340754;574.1731906055267;576.4005434348314;578.7945279425827;580.4369761331502;6463.353664633499;6478.643674597943;6531.477481801445;6575.506836987245;6623.138991931018;10353.223508236912;10681.946590267155;10691.41197234144;10724.892751072546;10806.08148307387;10297.07326340633;10403.687889363331;10418.270721049605;10461.163106951426;10462.529186186639;8128.9187108129345;8184.263416292562;8229.094799571923;8259.21537453941;8278.420510564203;7935.682572697027;7942.920570794218;8106.270435660819;8108.108108108221;8112.83774324522;9165.725028249164;9169.862452063091;9211.309151813506;9295.907040929504;9568.425894446356;9375.10936461035;9563.665271715456;9615.951920240354;9883.505824708593;10013.699589012342;6286.779962701284;6778;6892.276310987475;7322.890156647548;7440.255974402517;8157.143499932659;8177.34581233488;8231.382646301432;8234.794130146794;8278.048024477263;7265.9273407265255;7314.158871729819;7397.8150546236775;7481.027466429547;7482.663280152515;7318.6706598202145;7361.889571656322;7399.48203625741;7435.442341824493;7440.479166458296;7464.888026679713;7496.700131994659;7544.321011109027;7547.660355283915;7580.469367144247;6929.3070692930305;6930.06444130036;6950.687219075053;6969.16370035599;7015.929840701732;6966.79099627012;7042.929570704227;7049.365557099885;7072.080629518336;7075.964620177072 05:41:37 INFO - PROCESS | 1353 | |4;prototype.html;357.3139572021718;359.51106495166584;361.67268621897193;361.9800910949897;365.8353740816633;6423.164988551488;6430.035494675795;6430.614163150214;6430.903536446957;6476.1257230273895;6371.108044873721;6371.267304260012;6375.234971803378;6377.808665740024;6383.138276332694;4638.7216766993915;4786.904261914759;4834.307992202736;4870.6103511718975;4913.828016019431;4845.515448455161;4850.466448690641;4859;4859.1496488114435;4888.511148885119;4803.663743537953;4843.709377437347;4847.418309802829;4850.708957462546;4852.393450818648;4821.7589120543835;4828.49300823412;4836;4840.177169881129;4855.660103792736;4210.179015092058;4212.620864122213;4215.662746980265;4215.957840421587;4217.746935183899;6017.879642407172;6102.389761023862;6117.602355846856;6154.692265386758;6158.137860699506;5583.664980101166;5612.859678508029;5615.971920140414;5622.269105016322;5625.943740562583;6662.233843108008;6735.191776986793;6736.393724564813;6738.59568425896;6739.224989126215;4607.608353289975;4609.331646911179;4609.67732258742;4617.099665565216;4622.722636641813;7004.929950700479;7006.054182685323;7090.432765378758;7091.964540177318;7093.8226544336285;4737.123632128068;4761.309610106515;4818.397700287464;4829.082474329936;4832.903341933142;4789.544993225638;4821.927671084936;4823.782929768169;4830.4444988826035;4858.222684370555;5572.665640061609;5646.124850648156;5651.12407576818;5652.85867853307;5658.207850900877;6783.321667833177;6818.249992500921;6830.658467076726;6831.760888368884;6838.521303508706;1710.4441056656635;1737.0793479455908;1737.7567140600327;1739.1043612539552;1739.1565090930887;1091.9727006824735;1094.3543309447464;1131.7962766701908;1145.6792098212513;1146.002977409659;6597.967010164918;6624;6627.734890604322;6627.933720662828;6630.1049358336;7010.263922288188;7047.048648432396;7048.788536343918;7057.153141623038;7059.929400705927;6568.014797780371;6611.471082313404;6698.832529186712;6722.193336799615;6730.461563074942;3843.2121415109837;3860.1507668312925;3865.2655995361356;3868.9226215475533;3872.593377695358;7304.306090921354;7345.816354591071;7375.225601311892;7376.926230737731;7387.963060184665;7240.312170343809;7247.746328878464;7249.420046396275;7284.307990740871;7290.45321600882;7186.425085993213;7331.230220826843;7380.741674041383;7399.371053460409;7400.037995060716;7081.752138675121;7105.502614816914;7118.323759242864;7124.109486314211;7129;6974.58152510851;6983.895241571279;6993.895091573732;6998.405135563534;6999.545029573062;7348.742794002184;7355.668994895135;7359.227281135618;7362.3373896349585;7376.188619251985;4744.246159964319;4813.15769740287;4823.686460380064;4857.441394239567;4880.194767863263;6988.091548098715;7047.7180912762915;7053.470989675692;7079.469039821931;7089.432845372255;6796.184457865088;6806.829829254309;6830.282820303796;6857.485688573277;6864.691088900911;6824.419924306291;6863.553868998499;6873.312668733087;6882.346177113166;6884.277150899284;6576.868462630816;6629.900551491828;6728.125343705287;6754.898676519954;6771;6857.691403886737;6898.724051038103;6900.723971041303;6901.827454313682;6902.827429314107;6685.732570697118;6715.764948226789;6730.596164230162;6737;6769.898451523132 05:41:37 INFO - PROCESS | 1353 | |5;yui.html;798.3094623150976;805.3798575097176;878.6792820620475;886.3352485635774;920.5627327019666;14274.500392486265;14342.498012569562;14378.712425751479;14415;14498.420063197473;12730.68173295668;14344.784828227585;14395.496157634485;14398.712025759478;14453.494127705533;918.7886786039231;932.4778124250407;939.8684184214216;946.5551190940247;947.6351604632197;918.2332752151962;931.2736065868634;934.8971613122585;934.9485778282192;935.2798345274135;989.515137582583;991.9950400247989;998.1665309466567;1000.6197644894929;1001.319103009953;985.4875464758321;992.692265397729;993.826080435928;997.1673652500099;997.5810159732894;733.7982054934882;737.6385571070191;738.896554482373;738.9002484664555;741.6032422653908;14905.850941490555;14981.10113393189;15067.321970511353;15075.170865602387;15132.319045642862;12442.191257568229;12676.68308292291;12698.301593412358;13111.541096061592;13200.20798752078;10663.680089597325;10666.200034997406;11026.283291586022;11083.113350931906;11132.109431245563;3787.242551489713;3849.3840985442193;3867.535895692507;3963.8414463421427;4022.255882661717;51850.48149518494;52320.73839630815;52417;52463.213051804254;52498.21252681213;10230.846537301946;10600.840987385196;10747.30142540748;10782.838257426145;10823.458827058615;21205.78794212069;21292.467688307606;21373.572528549343;21387.78612213858;21394.572108557742;7781.41639377049;7794.766157015299;7802.180771019075;7997.320227780704;8074.152214017444;4343.2399330117105;4442.422485076984;4500.887477813016;4542.477615074243;4623.42207224097;3374.5106959490736;3435.811030393352;3438.948415773765;3445.758796884244;3452.723782097426;589.1398558105129;594.913737508059;599.2778701664483;605.9606125601822;620.7734177025353;746.3059354800088;749.0861149397726;752.0974830203777;762.649181376573;770.6455030685947;8655.437396569328;8692.391532592785;9023.368364214442;9050.366474346733;9098.226650734628;654.1953397321226;658.7035833874776;686.7321744519542;747.5327920049968;747.9551226926402;4196.475440569929;4410.404595379647;4444.1333939881415;4453.955460445419;4583.72497650142;57870.710646446496;59727.70136149378;59853.10220346698;60214.39785602176;60217.698911506035;52322.73838630782;52383.47616523786;52806.735966319924;53144;53233.2015019775;45998.310025349645;46485.76757116193;48776.512234877904;49023;49406;8689.391742578211;8993.640254389751;9035.096490350912;9113.088691130833;9204.127152870535;34830.82584587061;34887.12782180466;34908.82545587256;35273.647263528066;35795.92612221638;42889.78555107205;43612.38325700468;43776;44620;44636.55363446454;11872;11872.228305160137;11935.82096268574;11997.280163190237;12143.81784273219;12530.122891397516;12741.362931853186;13058.281794501394;13113.606591802261;13498;11309;11519.25124866881;11574.768504630028;11882.28706277626;12099.395030248277;12013.45939432745;12077.818832717341;12091.75816483683;12176.756464870476;12260.26438413698;11732.354720490455;11741.412929353328;11856.58501952462;11939.098188533419;12020.158588898694;9871.358361706467;9912.950435247778;9914.40513569188;9981.251406144424;10120.089191972464;9682.606855691693;10144.797104058025;10170.593176273162;10198.694039178836;10218.489075546044 05:41:37 INFO - PROCESS | 1353 | __end_tp_report 05:41:37 INFO - PROCESS | 1353 | __start_cc_report 05:41:37 INFO - PROCESS | 1353 | _x_x_mozilla_cycle_collect,336 05:41:37 INFO - PROCESS | 1353 | __end_cc_report 05:41:37 INFO - PROCESS | 1353 | __startTimestamp1461328897255__endTimestamp 05:41:37 INFO - PROCESS | 1353 | 05:41:37 INFO - PROCESS | 1353 | ------- Summary: start ------- 05:41:37 INFO - PROCESS | 1353 | Number of tests: 6 05:41:37 INFO - PROCESS | 1353 | 05:41:37 INFO - PROCESS | 1353 | [#0] dojo.html Cycles:165 Average:5532.89 Median:5751.00 stddev:615.20 (10.7%) stddev-sans-first:590.65 05:41:37 INFO - PROCESS | 1353 | Values: 3258.9 3321.0 3359.0 3391.1 3397.0 5491.3 5503.0 5520.2 5533.7 5560.5 5480.9 5510.1 5526.6 5555.6 5556.4 5046.4 5060.3 5131.6 5137.7 5147.6 4883.2 5023.7 5118.8 5147.4 5184.1 5058.5 5065.3 5137.3 5145.3 5168.0 5139.8 5157.3 5175.9 5182.2 5208.3 4884.9 4891.3 5026.0 5071.0 5119.2 5325.7 5326.4 5351.1 5360.0 5392.4 5748.2 5872.4 5907.4 5917.3 5938.2 5939.2 5987.5 6024.9 6028.1 6042.7 5563.7 5578.9 5595.0 5601.5 5602.5 5822.2 6036.7 6071.2 6079.7 6108.3 5831.4 5863.0 5863.9 5866.7 5896.7 5904.6 5910.8 5936.2 5943.2 5956.8 5675.9 5887.9 5896.3 5901.9 5981.5 5824.9 5880.3 5883.7 5884.0 5915.8 4510.1 4510.5 4513.8 4517.7 4521.8 4030.5 4034.5 4054.4 4095.4 4107.8 5492.6 5709.3 5732.2 5749.9 5816.7 6002.0 6022.4 6022.5 6025.5 6026.6 5517.5 5669.5 5745.7 5762.9 5785.7 5129.7 5148.3 5150.5 5169.9 5176.5 6234.1 6253.8 6254.8 6256.8 6269.2 5804.6 5905.2 5915.6 5988.5 6030.0 6165.4 6169.1 6169.2 6171.0 6205.6 5667.3 5915.7 5921.9 5922.5 5932.3 5974.7 5990.6 6011.5 6054.5 6059.2 5745.1 5774.7 5801.5 5818.5 5820.7 5614.3 5747.9 5796.3 5818.2 5829.7 5744.4 5800.7 5802.6 5819.7 5866.9 5852.3 5855.9 5879.7 5888.6 5898.5 5555.9 5743.2 5744.9 5751.0 5756.4 05:41:37 INFO - PROCESS | 1353 | 05:41:37 INFO - PROCESS | 1353 | [#1] ext.html Cycles:180 Average:60746.51 Median:40237.70 stddev:141604.12 (351.9%) stddev-sans-first:141929.14 05:41:37 INFO - PROCESS | 1353 | Values: 514.2 559.1 567.7 571.0 614.1 38714.8 39444.8 39475.8 39505.6 39513.2 43595.6 44275.1 44340.0 44354.1 44367.6 8807.6 9030.7 9038.0 9046.3 9048.9 8777.0 8919.9 8933.3 8940.4 8946.4 9016.5 9154.1 9156.9 9157.6 9160.6 9029.4 9074.8 9093.3 9095.9 9107.5 8967.7 9127.2 9141.3 9159.5 9186.7 44366.8 44454.0 44773.0 44842.8 44924.6 3502.4 3680.4 3711.4 3715.9 3762.7 32524.0 32716.0 32896.0 32993.7 33245.2 4270.6 4291.0 4297.1 4410.2 4430.4 293331.0 293758.0 294240.0 297521.0 299902.0 45652.0 46084.0 46414.1 57027.0 57285.1 44287.3 44428.3 44529.3 44600.0 44653.6 16606.8 16839.8 16882.8 16926.6 16954.9 13818.4 13873.2 13919.6 13962.9 14021.4 15576.6 15690.5 15716.8 15755.3 15837.0 5806.9 5999.5 6067.0 6087.2 6156.6 1029.0 1100.8 1127.1 1148.9 1157.9 30310.2 30701.4 31235.4 31357.7 31618.8 1094.3 1137.4 1177.7 1213.7 1284.5 15800.3 16515.1 17162.9 17207.1 17609.9 420672.0 861412.0 882291.0 885508.0 890525.0 57907.7 58446.0 58527.0 58605.0 58799.0 1474.6 1509.3 1517.7 1557.0 1562.8 29286.4 30497.2 30944.0 31028.0 33183.8 51583.0 52214.7 52243.2 52243.5 52300.2 275427.0 275654.0 277694.0 278519.0 279771.0 35516.0 35608.1 36646.8 36722.0 36809.9 47628.0 47935.3 48162.6 49305.3 49571.0 40165.0 40258.4 40259.2 41497.4 42459.0 39369.6 40915.2 40938.8 41003.6 41401.2 39391.2 39512.6 39966.6 40217.0 40335.6 35638.5 35812.8 35993.0 36028.6 36071.3 27192.9 27782.6 27810.2 27988.0 28014.3 05:41:37 INFO - PROCESS | 1353 | 05:41:37 INFO - PROCESS | 1353 | [#2] jquery.html Cycles:180 Average:24858.22 Median:36771.63 stddev:66881.43 (181.9%) stddev-sans-first:67043.80 05:41:37 INFO - PROCESS | 1353 | Values: 382.4 392.6 397.1 398.0 402.4 17422.7 19943.7 20244.7 20254.1 20263.3 18316.6 18358.2 18677.6 19107.6 19114.0 5634.4 5775.8 5786.0 5807.7 5834.0 4404.0 6224.9 6476.0 6480.6 6521.9 5960.8 6424.6 6426.3 6439.1 6456.6 6175.7 6181.0 6181.6 6197.2 6215.6 5514.2 5515.4 5547.3 5569.0 5573.1 14225.8 14260.6 14528.6 14737.7 14744.9 2271.9 2331.1 2515.0 2710.0 2957.5 9584.2 9699.8 9815.1 9847.7 10199.4 1615.9 1620.1 1628.9 1655.7 1683.1 65428.7 67679.7 68291.7 68774.0 69211.0 10477.9 10480.3 10582.7 10612.1 10846.5 14970.9 15134.4 15145.4 15206.6 15245.6 8287.6 8333.5 8347.9 8552.8 8612.4 8332.8 8362.0 8386.3 8507.8 8518.0 4626.4 4646.9 4664.7 4677.6 4764.1 1959.2 2012.3 2013.3 2029.0 2060.3 953.3 970.9 1012.4 1071.5 1088.5 17504.4 17626.4 17642.9 17785.5 18273.5 976.6 1020.6 1087.7 1092.9 1117.5 9955.2 10318.9 10349.2 10353.4 10369.6 330737.0 337708.0 444762.0 449798.0 450224.0 71491.3 73382.3 73495.6 74725.0 76020.0 470.1 487.0 489.4 490.4 500.3 11238.9 11462.2 11735.4 11737.4 11838.3 30670.0 36348.0 36438.6 36483.8 37059.4 51064.2 51600.0 51821.7 52301.7 52538.0 7802.2 8723.4 8728.7 8844.1 8912.0 12571.2 12795.6 12921.6 13024.0 13215.7 5527.2 8092.6 10986.6 11238.5 11304.4 11254.3 11600.8 11616.7 11829.6 12011.9 11587.8 11603.2 11715.9 11802.7 12096.5 8661.6 8760.6 8767.1 8777.8 9001.0 11470.2 11474.3 11495.7 11540.5 11622.4 05:41:37 INFO - PROCESS | 1353 | 05:41:37 INFO - PROCESS | 1353 | [#3] mootools.html Cycles:180 Average:5987.63 Median:2927.37 stddev:3127.04 (106.8%) stddev-sans-first:3118.28 05:41:37 INFO - PROCESS | 1353 | Values: 1581.6 1602.6 1826.3 1949.9 1988.7 7312.9 8366.2 8597.8 8785.0 8811.6 8494.8 8566.1 8570.8 8617.2 8625.4 2394.3 2403.5 2412.7 2415.1 2424.0 2394.1 2414.5 2424.3 2434.3 2448.7 2384.6 2387.8 2419.0 2420.0 2427.2 2364.5 2368.4 2378.2 2380.3 2425.9 2403.0 2408.8 2432.3 2443.3 2448.7 8656.8 8717.0 8741.7 8764.0 8827.0 5122.3 5218.8 5266.2 5266.3 5281.9 3186.8 3198.6 3233.8 3234.0 3285.0 1031.9 2068.0 2122.4 2138.1 2140.8 11725.0 11735.1 11744.4 11801.2 11848.7 4396.5 4481.2 4482.8 4514.7 4516.9 9467.3 9479.0 9494.1 9547.8 9630.3 5160.0 5216.5 5226.0 5237.9 5238.1 4740.3 4789.8 4836.5 4859.2 4865.6 3805.2 3854.8 3869.1 3886.1 3927.9 1188.6 1193.2 1204.7 1207.9 1212.7 1467.5 1468.3 1477.4 1489.1 1512.8 8398.8 8439.2 8444.1 8447.8 8451.4 572.8 574.2 576.4 578.8 580.4 6463.4 6478.6 6531.5 6575.5 6623.1 10353.2 10681.9 10691.4 10724.9 10806.1 10297.1 10403.7 10418.3 10461.2 10462.5 8128.9 8184.3 8229.1 8259.2 8278.4 7935.7 7942.9 8106.3 8108.1 8112.8 9165.7 9169.9 9211.3 9295.9 9568.4 9375.1 9563.7 9616.0 9883.5 10013.7 6286.8 6778.0 6892.3 7322.9 7440.3 8157.1 8177.3 8231.4 8234.8 8278.0 7265.9 7314.2 7397.8 7481.0 7482.7 7318.7 7361.9 7399.5 7435.4 7440.5 7464.9 7496.7 7544.3 7547.7 7580.5 6929.3 6930.1 6950.7 6969.2 7015.9 6966.8 7042.9 7049.4 7072.1 7076.0 05:41:37 INFO - PROCESS | 1353 | 05:41:37 INFO - PROCESS | 1353 | [#4] prototype.html Cycles:180 Average:5702.31 Median:6572.44 stddev:1740.75 (26.5%) stddev-sans-first:1698.78 05:41:37 INFO - PROCESS | 1353 | Values: 357.3 359.5 361.7 362.0 365.8 6423.2 6430.0 6430.6 6430.9 6476.1 6371.1 6371.3 6375.2 6377.8 6383.1 4638.7 4786.9 4834.3 4870.6 4913.8 4845.5 4850.5 4859.0 4859.1 4888.5 4803.7 4843.7 4847.4 4850.7 4852.4 4821.8 4828.5 4836.0 4840.2 4855.7 4210.2 4212.6 4215.7 4216.0 4217.7 6017.9 6102.4 6117.6 6154.7 6158.1 5583.7 5612.9 5616.0 5622.3 5625.9 6662.2 6735.2 6736.4 6738.6 6739.2 4607.6 4609.3 4609.7 4617.1 4622.7 7004.9 7006.1 7090.4 7092.0 7093.8 4737.1 4761.3 4818.4 4829.1 4832.9 4789.5 4821.9 4823.8 4830.4 4858.2 5572.7 5646.1 5651.1 5652.9 5658.2 6783.3 6818.2 6830.7 6831.8 6838.5 1710.4 1737.1 1737.8 1739.1 1739.2 1092.0 1094.4 1131.8 1145.7 1146.0 6598.0 6624.0 6627.7 6627.9 6630.1 7010.3 7047.0 7048.8 7057.2 7059.9 6568.0 6611.5 6698.8 6722.2 6730.5 3843.2 3860.2 3865.3 3868.9 3872.6 7304.3 7345.8 7375.2 7376.9 7388.0 7240.3 7247.7 7249.4 7284.3 7290.5 7186.4 7331.2 7380.7 7399.4 7400.0 7081.8 7105.5 7118.3 7124.1 7129.0 6974.6 6983.9 6993.9 6998.4 6999.5 7348.7 7355.7 7359.2 7362.3 7376.2 4744.2 4813.2 4823.7 4857.4 4880.2 6988.1 7047.7 7053.5 7079.5 7089.4 6796.2 6806.8 6830.3 6857.5 6864.7 6824.4 6863.6 6873.3 6882.3 6884.3 6576.9 6629.9 6728.1 6754.9 6771.0 6857.7 6898.7 6900.7 6901.8 6902.8 6685.7 6715.8 6730.6 6737.0 6769.9 05:41:37 INFO - PROCESS | 1353 | 05:41:37 INFO - PROCESS | 1353 | [#5] yui.html Cycles:180 Average:14473.27 Median:24536.98 stddev:16469.08 (67.1%) stddev-sans-first:16483.27 05:41:37 INFO - PROCESS | 1353 | Values: 798.3 805.4 878.7 886.3 920.6 14274.5 14342.5 14378.7 14415.0 14498.4 12730.7 14344.8 14395.5 14398.7 14453.5 918.8 932.5 939.9 946.6 947.6 918.2 931.3 934.9 934.9 935.3 989.5 992.0 998.2 1000.6 1001.3 985.5 992.7 993.8 997.2 997.6 733.8 737.6 738.9 738.9 741.6 14905.9 14981.1 15067.3 15075.2 15132.3 12442.2 12676.7 12698.3 13111.5 13200.2 10663.7 10666.2 11026.3 11083.1 11132.1 3787.2 3849.4 3867.5 3963.8 4022.3 51850.5 52320.7 52417.0 52463.2 52498.2 10230.8 10600.8 10747.3 10782.8 10823.5 21205.8 21292.5 21373.6 21387.8 21394.6 7781.4 7794.8 7802.2 7997.3 8074.2 4343.2 4442.4 4500.9 4542.5 4623.4 3374.5 3435.8 3438.9 3445.8 3452.7 589.1 594.9 599.3 606.0 620.8 746.3 749.1 752.1 762.6 770.6 8655.4 8692.4 9023.4 9050.4 9098.2 654.2 658.7 686.7 747.5 748.0 4196.5 4410.4 4444.1 4454.0 4583.7 57870.7 59727.7 59853.1 60214.4 60217.7 52322.7 52383.5 52806.7 53144.0 53233.2 45998.3 46485.8 48776.5 49023.0 49406.0 8689.4 8993.6 9035.1 9113.1 9204.1 34830.8 34887.1 34908.8 35273.6 35795.9 42889.8 43612.4 43776.0 44620.0 44636.6 11872.0 11872.2 11935.8 11997.3 12143.8 12530.1 12741.4 13058.3 13113.6 13498.0 11309.0 11519.3 11574.8 11882.3 12099.4 12013.5 12077.8 12091.8 12176.8 12260.3 11732.4 11741.4 11856.6 11939.1 12020.2 9871.4 9913.0 9914.4 9981.3 10120.1 9682.6 10144.8 10170.6 10198.7 10218.5 05:41:37 INFO - PROCESS | 1353 | -------- Summary: end -------- 05:41:37 INFO - PROCESS | 1353 | 05:41:37 INFO - TEST-INFO | 1353: exit 0 05:41:37 INFO - TEST-OK | dromaeo_css | took 1109469ms 05:41:37 INFO - TEST-START | kraken 05:41:37 INFO - operating with platform_type : linux_ 05:41:37 INFO - Initialising browser for kraken test... 05:41:37 INFO - TEST-INFO | started process 1597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU2Bour/profile http://localhost:35744/getInfo.html) 05:41:41 INFO - PROCESS | 1597 | 05:41:41 INFO - PROCESS | 1597 | (process:1672): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:41:42 INFO - PROCESS | 1597 | __metrics Screen width/height:1600/1200 05:41:42 INFO - PROCESS | 1597 | colorDepth:24 05:41:42 INFO - PROCESS | 1597 | Browser inner width/height: 1024/697 05:41:42 INFO - PROCESS | 1597 | __metrics 05:41:43 ERROR - PROCESS | 1597 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:41:44 INFO - TEST-INFO | 1597: exit 0 05:41:44 INFO - Browser initialized. 05:41:44 INFO - Running cycle 1/1 for kraken test... 05:41:44 INFO - TEST-INFO | started process 1723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU2Bour/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:46 INFO - PROCESS | 1723 | 05:41:46 INFO - PROCESS | 1723 | (process:1793): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:41:56 INFO - PROCESS | 1723 | RSS: Main: 151506944 05:41:56 INFO - PROCESS | 1723 | 05:41:58 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35744/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:59 INFO - PROCESS | 1723 | RSS: Main: 156172288 05:41:59 INFO - PROCESS | 1723 | 05:42:02 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35744/tests/kraken/driver.html?testName=audio-dft) 05:42:02 INFO - PROCESS | 1723 | RSS: Main: 156102656 05:42:02 INFO - PROCESS | 1723 | 05:42:05 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35744/tests/kraken/driver.html?testName=audio-fft) 05:42:06 INFO - PROCESS | 1723 | RSS: Main: 156925952 05:42:06 INFO - PROCESS | 1723 | 05:42:08 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35744/tests/kraken/driver.html?testName=audio-oscillator) 05:42:08 INFO - PROCESS | 1723 | RSS: Main: 156823552 05:42:08 INFO - PROCESS | 1723 | 05:42:10 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35744/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:42:11 INFO - PROCESS | 1723 | RSS: Main: 156864512 05:42:11 INFO - PROCESS | 1723 | 05:42:14 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35744/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:15 INFO - PROCESS | 1723 | RSS: Main: 157167616 05:42:15 INFO - PROCESS | 1723 | 05:42:18 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35744/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:19 INFO - PROCESS | 1723 | RSS: Main: 157786112 05:42:19 INFO - PROCESS | 1723 | 05:42:22 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35744/tests/kraken/driver.html?testName=json-parse-financial) 05:42:22 INFO - PROCESS | 1723 | RSS: Main: 157024256 05:42:22 INFO - PROCESS | 1723 | 05:42:24 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35744/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:24 INFO - PROCESS | 1723 | RSS: Main: 157552640 05:42:24 INFO - PROCESS | 1723 | 05:42:26 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35744/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:27 INFO - PROCESS | 1723 | RSS: Main: 156803072 05:42:27 INFO - PROCESS | 1723 | 05:42:29 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35744/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:42:29 INFO - PROCESS | 1723 | RSS: Main: 157249536 05:42:29 INFO - PROCESS | 1723 | 05:42:32 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:42:32 INFO - PROCESS | 1723 | RSS: Main: 157237248 05:42:32 INFO - PROCESS | 1723 | 05:42:35 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:42:36 INFO - PROCESS | 1723 | RSS: Main: 157810688 05:42:36 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | Cycle 1(1): loaded http://localhost:35744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35744/tests/kraken/driver.html?testName=ai-astar) 05:42:37 INFO - PROCESS | 1723 | RSS: Main: 158879744 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | __start_tp_report 05:42:37 INFO - PROCESS | 1723 | _x_x_mozilla_page_load 05:42:37 INFO - PROCESS | 1723 | _x_x_mozilla_page_load_details 05:42:37 INFO - PROCESS | 1723 | |i|pagename|runs| 05:42:37 INFO - PROCESS | 1723 | |0;ai-astar;112;105;112;111;116;125;112;111;112;112 05:42:37 INFO - PROCESS | 1723 | |1;audio-beat-detection;154;127;154;178;135;162;153;130;182;128 05:42:37 INFO - PROCESS | 1723 | |2;audio-dft;163;164;163;164;166;163;163;163;166;164 05:42:37 INFO - PROCESS | 1723 | |3;audio-fft;75;77;77;166;73;76;75;74;171;77 05:42:37 INFO - PROCESS | 1723 | |4;audio-oscillator;92;94;139;94;93;92;148;92;93;142 05:42:37 INFO - PROCESS | 1723 | |5;imaging-gaussian-blur;118;118;118;117;117;117;118;118;118;117 05:42:37 INFO - PROCESS | 1723 | |6;imaging-darkroom;146;146;146;146;149;146;147;146;148;147 05:42:37 INFO - PROCESS | 1723 | |7;imaging-desaturate;96;98;96;96;96;96;96;96;96;96 05:42:37 INFO - PROCESS | 1723 | |8;json-parse-financial;61;57;57;57;56;56;60;63;56;61 05:42:37 INFO - PROCESS | 1723 | |9;json-stringify-tinderbox;64;65;66;65;75;65;64;65;65;65 05:42:37 INFO - PROCESS | 1723 | |10;stanford-crypto-aes;80;81;83;88;89;81;89;83;81;80 05:42:37 INFO - PROCESS | 1723 | |11;stanford-crypto-ccm;121;114;119;114;115;119;119;116;113;118 05:42:37 INFO - PROCESS | 1723 | |12;stanford-crypto-pbkdf2;137;150;148;148;154;136;148;142;151;144 05:42:37 INFO - PROCESS | 1723 | |13;stanford-crypto-sha256-iterative;67;67;69;68;69;67;66;64;68;67 05:42:37 INFO - PROCESS | 1723 | __end_tp_report 05:42:37 INFO - PROCESS | 1723 | __start_cc_report 05:42:37 INFO - PROCESS | 1723 | _x_x_mozilla_cycle_collect,838 05:42:37 INFO - PROCESS | 1723 | __end_cc_report 05:42:37 INFO - PROCESS | 1723 | __startTimestamp1461328957931__endTimestamp 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | ------- Summary: start ------- 05:42:37 INFO - PROCESS | 1723 | Number of tests: 14 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:5.05 (4.5%) stddev-sans-first:5.35 05:42:37 INFO - PROCESS | 1723 | Values: 112.0 105.0 112.0 111.0 116.0 125.0 112.0 111.0 112.0 112.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:154.00 stddev:20.08 (13.0%) stddev-sans-first:21.26 05:42:37 INFO - PROCESS | 1723 | Values: 154.0 127.0 154.0 178.0 135.0 162.0 153.0 130.0 182.0 128.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 05:42:37 INFO - PROCESS | 1723 | Values: 163.0 164.0 163.0 164.0 166.0 163.0 163.0 163.0 166.0 164.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.25 (52.0%) stddev-sans-first:41.02 05:42:37 INFO - PROCESS | 1723 | Values: 75.0 77.0 77.0 166.0 73.0 76.0 75.0 74.0 171.0 77.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:92.50 stddev:24.33 (26.3%) stddev-sans-first:25.11 05:42:37 INFO - PROCESS | 1723 | Values: 92.0 94.0 139.0 94.0 93.0 92.0 148.0 92.0 93.0 142.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:42:37 INFO - PROCESS | 1723 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 05:42:37 INFO - PROCESS | 1723 | Values: 146.0 146.0 146.0 146.0 149.0 146.0 147.0 146.0 148.0 147.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:42:37 INFO - PROCESS | 1723 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.50 stddev:2.59 (4.4%) stddev-sans-first:2.57 05:42:37 INFO - PROCESS | 1723 | Values: 61.0 57.0 57.0 57.0 56.0 56.0 60.0 63.0 56.0 61.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:65.00 stddev:3.25 (5.0%) stddev-sans-first:3.37 05:42:37 INFO - PROCESS | 1723 | Values: 64.0 65.0 66.0 65.0 75.0 65.0 64.0 65.0 65.0 65.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:3.72 (4.5%) stddev-sans-first:3.72 05:42:37 INFO - PROCESS | 1723 | Values: 80.0 81.0 83.0 88.0 89.0 81.0 89.0 83.0 81.0 80.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:118.50 stddev:2.74 (2.3%) stddev-sans-first:2.45 05:42:37 INFO - PROCESS | 1723 | Values: 121.0 114.0 119.0 114.0 115.0 119.0 119.0 116.0 113.0 118.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:148.00 stddev:5.94 (4.0%) stddev-sans-first:5.38 05:42:37 INFO - PROCESS | 1723 | Values: 137.0 150.0 148.0 148.0 154.0 136.0 148.0 142.0 151.0 144.0 05:42:37 INFO - PROCESS | 1723 | 05:42:37 INFO - PROCESS | 1723 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.48 (2.2%) stddev-sans-first:1.56 05:42:37 INFO - PROCESS | 1723 | Values: 67.0 67.0 69.0 68.0 69.0 67.0 66.0 64.0 68.0 67.0 05:42:37 INFO - PROCESS | 1723 | -------- Summary: end -------- 05:42:37 INFO - PROCESS | 1723 | 05:42:38 INFO - TEST-INFO | 1723: exit 0 05:42:38 INFO - TEST-OK | kraken | took 60923ms 05:42:38 INFO - SUITE-END | took 1170s 05:42:39 INFO - Completed test suite (00:19:30) 05:42:39 INFO - javascript benchmark 05:42:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3258.934821303574, 3320.950185747214, 3358.983205083974, 3391.067456449476, 3396.966030339696, 5491.28613280273, 5502.972485137574, 5520.150794363165, 5533.6679799212025, 5560.499555040045, 5480.862978425532, 5510.090835012228, 5526.613137080406, 5555.555555555556, 5556.444355564441, 5046.369203849528, 5060.342155519796, 5131.640785145041, 5137.717425541612, 5147.613928955325, 4883.19427294496, 5023.673461225008, 5118.820841270556, 5147.356580427447, 5184.066867963765, 5058.494150584949, 5065.341505604266, 5137.255098010786, 5145.253938178962, 5168.0, 5139.7687104080405, 5157.30376399185, 5175.922361164586, 5182.196759502245, 5208.270842082112, 4884.877878053042, 4891.339669144655, 5026.0, 5071.0, 5119.206522988943, 5325.680459172462, 5326.387465441485, 5351.117065684196, 5359.9732001340135, 5392.40683524812, 5748.16651585522, 5872.442117998783, 5907.350191478934, 5917.349091599964, 5938.168656388109, 5939.227900372967, 5987.491063259628, 6024.939750602482, 6028.0957856321465, 6042.667653279068, 5563.721813909288, 5578.888422231573, 5595.048841696921, 5601.5238704709745, 5602.4957753802355, 5822.243108395882, 6036.728347224298, 6071.150038994544, 6079.6960151992225, 6108.3280839107665, 5831.3877042910735, 5863.0, 5863.853403664943, 5866.70666466675, 5896.734646940898, 5904.61619994699, 5910.7931222407005, 5936.168936348915, 5943.197668314809, 5956.791512297049, 5675.943240567624, 5887.852803679856, 5896.3219229788265, 5901.940980590225, 5981.5214782817275, 5824.883502330014, 5880.323762767251, 5883.705814709333, 5884.029135192731, 5915.792947246911, 4510.120526497301, 4510.481294651091, 4513.751743654065, 4517.706349087299, 4521.796519156645, 4030.536488303824, 4034.455348527911, 4054.412110243998, 4095.365218391154, 4107.835686572504, 5492.588055895823, 5709.257796486513, 5732.168835518826, 5749.9425005750245, 5816.680082595498, 6001.969990150022, 6022.36765139654, 6022.518198544106, 6025.548083893726, 6026.578139530278, 5517.531009864127, 5669.518090962314, 5745.68398738065, 5762.884742305214, 5785.681787501644, 5129.692218466904, 5148.30497882781, 5150.459201783834, 5169.948300517022, 5176.50823171798, 6234.064890266496, 6253.843653908598, 6254.781082662085, 6256.843578910472, 6269.247690277105, 5804.622699524517, 5905.173275741314, 5915.556333274935, 5988.520918326611, 6030.005049166838, 6165.445109940127, 6169.105479705508, 6169.167162433194, 6171.0, 6205.627662340274, 5667.263255776723, 5915.70421478933, 5921.940780592139, 5922.526197904243, 5932.347441781314, 5974.731137098928, 5990.580659353977, 6011.549133814894, 6054.485368743706, 6059.182010428536, 5745.080787074048, 5774.682392468455, 5801.535877129904, 5818.4763371296785, 5820.650760954356, 5614.326280846324, 5747.8563035924435, 5796.275465566804, 5818.2436283282905, 5829.737661805144, 5744.396838331915, 5800.651960882192, 5802.564807639528, 5819.738111785065, 5866.911996320144, 5852.326982397079, 5855.882882342415, 5879.676617786063, 5888.587798854211, 5898.498627616701, 5555.8888822224135, 5743.224664670216, 5744.942550574441, 5751.0, 5756.42435756421], "unit": "score", "name": "dojo.html", "value": 5492.968325660761}, {"lowerIsBetter": false, "replicates": [514.1901505129422, 559.1026402623786, 567.690608618303, 570.9657420554767, 614.1156734302604, 38714.806425967865, 39444.80277598608, 39475.802620986855, 39505.60494395055, 39513.20973580526, 43595.56404435955, 44275.11449771011, 44340.0, 44354.11291774162, 44367.556324436744, 8807.647694092244, 9030.68392606259, 9037.960634527015, 9046.276297896185, 9048.909510904905, 8776.956115219415, 8919.866202006975, 8933.330000249975, 8940.374173807835, 8946.418482798597, 9016.549172541347, 9154.084591540859, 9156.862647060267, 9157.587908544132, 9160.633574657006, 9029.367944243906, 9074.818503629891, 9093.272538196994, 9095.863562046574, 9107.544622768835, 8967.730968070968, 9127.17855393011, 9141.314401419853, 9159.542022898895, 9186.724398268063, 44366.77816610896, 44454.0, 44773.0, 44842.77578612086, 44924.55075449236, 3502.369573476773, 3680.392735198689, 3711.4432835074685, 3715.851365945359, 3762.698984081267, 32524.0, 32716.0, 32896.0, 32993.67006329954, 33245.16887077843, 4270.551592082848, 4290.957090429087, 4297.05464797744, 4410.206162890679, 4430.446194225722, 293331.0, 293758.0, 294240.0, 297521.0, 299901.99999999785, 45652.0, 46084.0, 46414.07171856544, 57027.0, 57285.14072288919, 44287.335689964675, 44428.3335749964, 44529.33206001913, 44600.0, 44653.55346446559, 16606.75089873653, 16839.831601684073, 16882.831171688373, 16926.57683557921, 16954.915225423792, 13818.37817298224, 13873.236971966639, 13919.582412527641, 13962.930185349009, 14021.369038393093, 15576.610584735472, 15690.450834220976, 15716.764248536281, 15755.291011904492, 15837.0, 5806.912896306559, 5999.490043346277, 6067.029275315928, 6087.178230938766, 6156.5998210117095, 1028.953697083633, 1100.8128618134936, 1127.143371038017, 1148.9482973266222, 1157.946482216201, 30310.242243943638, 30701.385972280877, 31235.375292494024, 31357.686423135932, 31618.841905790323, 1094.3215206571817, 1137.374444055766, 1177.664365655784, 1213.7329787446747, 1284.4926254129566, 15800.288986995383, 16515.091669958267, 17162.914185428992, 17207.13964301805, 17609.911950440164, 420672.0, 861412.0, 882291.0, 885508.0, 890525.0, 57907.71046144827, 58446.0, 58527.0, 58605.0, 58799.0, 1474.565003324022, 1509.2680050175657, 1517.658526831454, 1556.9844301557066, 1562.7733978573272, 29286.41427171487, 30497.237569060064, 30944.0, 31027.985065302397, 33183.834080830406, 51583.0, 52214.73892630512, 52243.21635175552, 52243.47756522538, 52300.21549676834, 275427.0, 275654.0, 277694.0, 278519.0, 279771.0, 35516.0, 35608.109797255274, 36646.816765916, 36722.0, 36809.89570312895, 47628.0, 47935.28097078617, 48162.59187040564, 49305.26042109443, 49571.0, 40165.0, 40258.396124058745, 40259.19481610293, 41497.37753933754, 42459.0, 39369.60630393659, 40915.181696366504, 40938.795306023276, 41003.58996409998, 41401.1719765609, 39391.212175755754, 39512.60487395204, 39966.600333996284, 40217.0, 40335.596644034355, 35638.465423019195, 35812.82093589516, 35993.0, 36028.639713602526, 36071.27857442784, 27192.864035679693, 27782.5832612515, 27810.16569502918, 27988.0, 28014.299642508286], "unit": "score", "name": "ext.html", "value": 19846.074195622496}, {"lowerIsBetter": false, "replicates": [382.42826973674363, 392.57993946477274, 397.126322091399, 398.0, 402.4446264155465, 17422.651546969068, 19943.700844487343, 20244.696329555067, 20254.08856601453, 20263.290784822533, 18316.633667326645, 18358.173882175302, 18677.626447471077, 19107.61784764304, 19114.044297785123, 5634.352049514297, 5775.797847075353, 5786.0, 5807.680577568232, 5833.970830145843, 4404.0, 6224.875502489947, 6475.999999999976, 6480.611163330215, 6521.869562608745, 5960.761569537213, 6424.614523128604, 6426.325235850239, 6439.098526206335, 6456.644884531373, 6175.69121543921, 6180.969095154518, 6181.629102253879, 6197.225346831646, 6215.627062376249, 5514.172874068881, 5515.448455154453, 5547.278853748987, 5568.972155139239, 5573.136163894603, 14225.78661320081, 14260.572182834532, 14528.636784080376, 14737.70524589513, 14744.852551474456, 2271.931842044741, 2331.1491305673308, 2514.962275565868, 2709.986450067757, 2957.4972254716536, 9584.233261339075, 9699.757506062335, 9815.067568580973, 9847.655332063343, 10199.4390308533, 1615.8707303415815, 1620.0684606351394, 1628.861546768526, 1655.7102507061215, 1683.1163639089455, 65428.67285663589, 67679.66160169168, 68291.65854170747, 68774.0, 69211.0, 10477.895221047693, 10480.266381353233, 10582.735431614272, 10612.097971672494, 10846.511906964206, 14970.925145374204, 15134.394624215129, 15145.394184232728, 15206.619834504005, 15245.6188595286, 8287.62705678246, 8333.541655209021, 8347.916520834713, 8552.828943421096, 8612.397132200811, 8332.750017499484, 8362.0, 8386.329093672492, 8507.82984340322, 8517.95741021291, 4626.444826620827, 4646.86059418218, 4664.720116793003, 4677.64917631179, 4764.071006153767, 1959.2358979997812, 2012.2655230840637, 2013.3154727392757, 2029.046348216336, 2060.268604645329, 953.2945620240972, 970.898055704155, 1012.3875055591409, 1071.4589132488043, 1088.4938503595865, 17504.387346442814, 17626.383076592258, 17642.911785440992, 17785.46643600694, 18273.543161421072, 976.6191185437685, 1020.5764607687875, 1087.7245360003917, 1092.9344239345664, 1117.5250518529592, 9955.153811926068, 10318.896811031944, 10349.172066234834, 10353.378797272188, 10369.585216591402, 330737.0, 337708.0, 444762.0, 449798.0, 450224.0, 71491.28508714847, 73382.2661773386, 73495.63252183705, 74725.0, 76020.0, 470.0786458541229, 486.9780859861315, 489.40048440659905, 490.36742602042966, 500.2870908954725, 11238.943805280922, 11462.197646164688, 11735.354555499189, 11737.35444550558, 11838.289702617525, 30670.0, 36348.0, 36438.63561364352, 36483.81758091299, 37059.444108337855, 51064.23403649023, 51600.0, 51821.7408912953, 52301.7384913073, 52538.0, 7802.180771018961, 8723.389362744547, 8728.69449569262, 8844.071372506052, 8911.955440222757, 12571.18287311322, 12795.552155674506, 12921.612351629467, 13024.0, 13215.735685286432, 5527.226188333556, 8092.554909480035, 10986.615468458565, 11238.494267758135, 11304.43477826089, 11254.324740515594, 11600.767984640092, 11616.709582260512, 11829.645110646694, 12011.939940300243, 11587.768244634892, 11603.187776855539, 11715.882841171479, 11802.704932376759, 12096.455659495168, 8661.566921654017, 8760.649574016968, 8767.079456656958, 8777.824443511221, 9000.954995224982, 11470.197086203885, 11474.311541307548, 11495.655130346104, 11540.480678369662, 11622.360770157722], "unit": "score", "name": "jquery.html", "value": 8592.272625154092}, {"lowerIsBetter": false, "replicates": [1581.5571639940817, 1602.575317540852, 1826.3151318255655, 1949.941501754948, 1988.7215789789432, 7312.890306645405, 8366.2470377666, 8597.785055373612, 8785.0, 8811.647534098636, 8494.78763030923, 8566.057733649293, 8570.785730356743, 8617.181367770052, 8625.396222264444, 2394.3056513611077, 2403.495265994143, 2412.662227288181, 2415.1184817541557, 2423.9757602424015, 2394.1022116706235, 2414.4808866093786, 2424.284835973392, 2434.3427274635837, 2448.742881997391, 2384.618461046233, 2387.785099341059, 2418.9637155442683, 2420.0319872051145, 2427.2232885476656, 2364.4561750797325, 2368.4197371643886, 2378.203301893868, 2380.309710184053, 2425.9029638814427, 2402.9639555406684, 2408.7832095111526, 2432.3311089450367, 2443.2548072837776, 2448.7306396296394, 8656.783580410478, 8717.0, 8741.737747867573, 8764.0, 8826.955865220698, 5122.334096567422, 5218.843434696965, 5266.15741481365, 5266.315379000744, 5281.947180528184, 3186.776925615208, 3198.552202691625, 3233.757468189872, 3233.951490727641, 3284.950725739116, 1031.9019693129142, 2068.0, 2122.3632910127053, 2138.1447421031557, 2140.8180304673965, 11725.0, 11735.061195104456, 11744.412779360997, 11801.173917825756, 11848.703782405422, 4396.494403143615, 4481.1709833680225, 4482.843100491467, 4514.68397212192, 4516.932246016312, 9467.289953253534, 9479.0, 9494.05059494045, 9547.809043819223, 9630.2777291702, 5160.0, 5216.478352164829, 5225.973870130625, 5237.895242095136, 5238.083335416287, 4740.312654665055, 4789.760511974388, 4836.540528649773, 4859.246816743411, 4865.635077369211, 3805.162864169878, 3854.7879866607045, 3869.071422858494, 3886.145048089416, 3927.8625248116177, 1188.5780547905542, 1193.2244041373176, 1204.747003129335, 1207.8610959739567, 1212.678640160358, 1467.523055007127, 1468.324570697491, 1477.4016523307862, 1489.0842132088687, 1512.8033355663692, 8398.79003024917, 8439.156084391634, 8444.113368096385, 8447.831043379098, 8451.366147538836, 572.7937942340754, 574.1731906055267, 576.4005434348314, 578.7945279425827, 580.4369761331502, 6463.353664633499, 6478.643674597943, 6531.477481801445, 6575.506836987245, 6623.138991931018, 10353.223508236912, 10681.946590267155, 10691.41197234144, 10724.892751072546, 10806.08148307387, 10297.07326340633, 10403.687889363331, 10418.270721049605, 10461.163106951426, 10462.529186186639, 8128.9187108129345, 8184.263416292562, 8229.094799571923, 8259.21537453941, 8278.420510564203, 7935.682572697027, 7942.920570794218, 8106.270435660819, 8108.108108108221, 8112.83774324522, 9165.725028249164, 9169.862452063091, 9211.309151813506, 9295.907040929504, 9568.425894446356, 9375.10936461035, 9563.665271715456, 9615.951920240354, 9883.505824708593, 10013.699589012342, 6286.779962701284, 6778.0, 6892.276310987475, 7322.890156647548, 7440.255974402517, 8157.143499932659, 8177.34581233488, 8231.382646301432, 8234.794130146794, 8278.048024477263, 7265.9273407265255, 7314.158871729819, 7397.8150546236775, 7481.027466429547, 7482.663280152515, 7318.6706598202145, 7361.889571656322, 7399.48203625741, 7435.442341824493, 7440.479166458296, 7464.888026679713, 7496.700131994659, 7544.321011109027, 7547.660355283915, 7580.469367144247, 6929.3070692930305, 6930.06444130036, 6950.687219075053, 6969.16370035599, 7015.929840701732, 6966.79099627012, 7042.929570704227, 7049.365557099885, 7072.080629518336, 7075.964620177072], "unit": "score", "name": "mootools.html", "value": 4881.846189202252}, {"lowerIsBetter": false, "replicates": [357.3139572021718, 359.51106495166584, 361.67268621897193, 361.9800910949897, 365.8353740816633, 6423.164988551488, 6430.035494675795, 6430.614163150214, 6430.903536446957, 6476.1257230273895, 6371.108044873721, 6371.267304260012, 6375.234971803378, 6377.808665740024, 6383.138276332694, 4638.7216766993915, 4786.904261914759, 4834.307992202736, 4870.6103511718975, 4913.828016019431, 4845.515448455161, 4850.466448690641, 4859.0, 4859.1496488114435, 4888.511148885119, 4803.663743537953, 4843.709377437347, 4847.418309802829, 4850.708957462546, 4852.393450818648, 4821.7589120543835, 4828.49300823412, 4836.0, 4840.177169881129, 4855.660103792736, 4210.179015092058, 4212.620864122213, 4215.662746980265, 4215.957840421587, 4217.746935183899, 6017.879642407172, 6102.389761023862, 6117.602355846856, 6154.692265386758, 6158.137860699506, 5583.664980101166, 5612.859678508029, 5615.971920140414, 5622.269105016322, 5625.943740562583, 6662.233843108008, 6735.191776986793, 6736.393724564813, 6738.59568425896, 6739.224989126215, 4607.608353289975, 4609.331646911179, 4609.67732258742, 4617.099665565216, 4622.722636641813, 7004.929950700479, 7006.054182685323, 7090.432765378758, 7091.964540177318, 7093.8226544336285, 4737.123632128068, 4761.309610106515, 4818.397700287464, 4829.082474329936, 4832.903341933142, 4789.544993225638, 4821.927671084936, 4823.782929768169, 4830.4444988826035, 4858.222684370555, 5572.665640061609, 5646.124850648156, 5651.12407576818, 5652.85867853307, 5658.207850900877, 6783.321667833177, 6818.249992500921, 6830.658467076726, 6831.760888368884, 6838.521303508706, 1710.4441056656635, 1737.0793479455908, 1737.7567140600327, 1739.1043612539552, 1739.1565090930887, 1091.9727006824735, 1094.3543309447464, 1131.7962766701908, 1145.6792098212513, 1146.002977409659, 6597.967010164918, 6624.0, 6627.734890604322, 6627.933720662828, 6630.1049358336, 7010.263922288188, 7047.048648432396, 7048.788536343918, 7057.153141623038, 7059.929400705927, 6568.014797780371, 6611.471082313404, 6698.832529186712, 6722.193336799615, 6730.461563074942, 3843.2121415109837, 3860.1507668312925, 3865.2655995361356, 3868.9226215475533, 3872.593377695358, 7304.306090921354, 7345.816354591071, 7375.225601311892, 7376.926230737731, 7387.963060184665, 7240.312170343809, 7247.746328878464, 7249.420046396275, 7284.307990740871, 7290.45321600882, 7186.425085993213, 7331.230220826843, 7380.741674041383, 7399.371053460409, 7400.037995060716, 7081.752138675121, 7105.502614816914, 7118.323759242864, 7124.109486314211, 7129.0, 6974.58152510851, 6983.895241571279, 6993.895091573732, 6998.405135563534, 6999.545029573062, 7348.742794002184, 7355.668994895135, 7359.227281135618, 7362.3373896349585, 7376.188619251985, 4744.246159964319, 4813.15769740287, 4823.686460380064, 4857.441394239567, 4880.194767863263, 6988.091548098715, 7047.7180912762915, 7053.470989675692, 7079.469039821931, 7089.432845372255, 6796.184457865088, 6806.829829254309, 6830.282820303796, 6857.485688573277, 6864.691088900911, 6824.419924306291, 6863.553868998499, 6873.312668733087, 6882.346177113166, 6884.277150899284, 6576.868462630816, 6629.900551491828, 6728.125343705287, 6754.898676519954, 6771.0, 6857.691403886737, 6898.724051038103, 6900.723971041303, 6901.827454313682, 6902.827429314107, 6685.732570697118, 6715.764948226789, 6730.596164230162, 6737.0, 6769.898451523132], "unit": "score", "name": "prototype.html", "value": 5134.969773588652}, {"lowerIsBetter": false, "replicates": [798.3094623150976, 805.3798575097176, 878.6792820620475, 886.3352485635774, 920.5627327019666, 14274.500392486265, 14342.498012569562, 14378.712425751479, 14415.0, 14498.420063197473, 12730.68173295668, 14344.784828227585, 14395.496157634485, 14398.712025759478, 14453.494127705533, 918.7886786039231, 932.4778124250407, 939.8684184214216, 946.5551190940247, 947.6351604632197, 918.2332752151962, 931.2736065868634, 934.8971613122585, 934.9485778282192, 935.2798345274135, 989.515137582583, 991.9950400247989, 998.1665309466567, 1000.6197644894929, 1001.319103009953, 985.4875464758321, 992.692265397729, 993.826080435928, 997.1673652500099, 997.5810159732894, 733.7982054934882, 737.6385571070191, 738.896554482373, 738.9002484664555, 741.6032422653908, 14905.850941490555, 14981.10113393189, 15067.321970511353, 15075.170865602387, 15132.319045642862, 12442.191257568229, 12676.68308292291, 12698.301593412358, 13111.541096061592, 13200.20798752078, 10663.680089597325, 10666.200034997406, 11026.283291586022, 11083.113350931906, 11132.109431245563, 3787.242551489713, 3849.3840985442193, 3867.535895692507, 3963.8414463421427, 4022.255882661717, 51850.48149518494, 52320.73839630815, 52417.0, 52463.213051804254, 52498.21252681213, 10230.846537301946, 10600.840987385196, 10747.30142540748, 10782.838257426145, 10823.458827058615, 21205.78794212069, 21292.467688307606, 21373.572528549343, 21387.78612213858, 21394.572108557742, 7781.41639377049, 7794.766157015299, 7802.180771019075, 7997.320227780704, 8074.152214017444, 4343.2399330117105, 4442.422485076984, 4500.887477813016, 4542.477615074243, 4623.42207224097, 3374.5106959490736, 3435.811030393352, 3438.948415773765, 3445.758796884244, 3452.723782097426, 589.1398558105129, 594.913737508059, 599.2778701664483, 605.9606125601822, 620.7734177025353, 746.3059354800088, 749.0861149397726, 752.0974830203777, 762.649181376573, 770.6455030685947, 8655.437396569328, 8692.391532592785, 9023.368364214442, 9050.366474346733, 9098.226650734628, 654.1953397321226, 658.7035833874776, 686.7321744519542, 747.5327920049968, 747.9551226926402, 4196.475440569929, 4410.404595379647, 4444.1333939881415, 4453.955460445419, 4583.72497650142, 57870.710646446496, 59727.70136149378, 59853.10220346698, 60214.39785602176, 60217.698911506035, 52322.73838630782, 52383.47616523786, 52806.735966319924, 53144.0, 53233.2015019775, 45998.310025349645, 46485.76757116193, 48776.512234877904, 49023.0, 49406.0, 8689.391742578211, 8993.640254389751, 9035.096490350912, 9113.088691130833, 9204.127152870535, 34830.82584587061, 34887.12782180466, 34908.82545587256, 35273.647263528066, 35795.92612221638, 42889.78555107205, 43612.38325700468, 43776.0, 44620.0, 44636.55363446454, 11872.0, 11872.228305160137, 11935.82096268574, 11997.280163190237, 12143.81784273219, 12530.122891397516, 12741.362931853186, 13058.281794501394, 13113.606591802261, 13498.0, 11309.0, 11519.25124866881, 11574.768504630028, 11882.28706277626, 12099.395030248277, 12013.45939432745, 12077.818832717341, 12091.75816483683, 12176.756464870476, 12260.26438413698, 11732.354720490455, 11741.412929353328, 11856.58501952462, 11939.098188533419, 12020.158588898694, 9871.358361706467, 9912.950435247778, 9914.40513569188, 9981.251406144424, 10120.089191972464, 9682.606855691693, 10144.797104058025, 10170.593176273162, 10198.694039178836, 10218.489075546044], "unit": "score", "name": "yui.html", "value": 6794.293906747165}], "name": "dromaeo_css", "value": 7364.589265677638}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 112.0, 111.0, 116.0, 125.0, 112.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 154.0, 178.0, 135.0, 162.0, 153.0, 130.0, 182.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 164.0, 166.0, 163.0, 163.0, 163.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 77.0, 166.0, 73.0, 76.0, 75.0, 74.0, 171.0, 77.0], "unit": "score", "name": "audio-fft", "value": 94.1}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 139.0, 94.0, 93.0, 92.0, 148.0, 92.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 149.0, 146.0, 147.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [61.0, 57.0, 57.0, 57.0, 56.0, 56.0, 60.0, 63.0, 56.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 65.0, 75.0, 65.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 83.0, 88.0, 89.0, 81.0, 89.0, 83.0, 81.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [121.0, 114.0, 119.0, 114.0, 115.0, 119.0, 119.0, 116.0, 113.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.8}, {"lowerIsBetter": true, "replicates": [137.0, 150.0, 148.0, 148.0, 154.0, 136.0, 148.0, 142.0, 151.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 68.0, 69.0, 67.0, 66.0, 64.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1527.1000000000001}]} 05:42:39 INFO - Return code: 0 05:42:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:42:39 ERROR - # TBPL SUCCESS # 05:42:39 INFO - Running post-action listener: _resource_record_post_action 05:42:39 INFO - Running post-run listener: _resource_record_post_run 05:42:40 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 503595008; Read time: 340; Write time: 1164944 05:42:40 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 253054976; Read time: 0; Write time: 714780 05:42:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 250540032; Read time: 340; Write time: 450164 05:42:40 INFO - Running post-run listener: _upload_blobber_files 05:42:40 INFO - Blob upload gear active. 05:42:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42:40 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 05:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:42:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:42:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:41 INFO - (blobuploader) - INFO - Done attempting. 05:42:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:42:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:42:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:42 INFO - (blobuploader) - INFO - Done attempting. 05:42:42 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:42 INFO - Return code: 0 05:42:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51ab2c34137797b834c835755cc4b173bf9478afda1498f89185a7b61c2e46c483011fba7721faadc3849ee340240ef1f4e9ec6ae915ba82d4bb1e9936477290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb76a75f8eb9f55684cbf1f03ca706b1a05046c67c867d26ab737052da289527e243687b3dc85e4de3d68f9f64386a4022b5a9ae641d90eed169215f4ba56705"} 05:42:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:42 INFO - Contents: 05:42:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51ab2c34137797b834c835755cc4b173bf9478afda1498f89185a7b61c2e46c483011fba7721faadc3849ee340240ef1f4e9ec6ae915ba82d4bb1e9936477290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb76a75f8eb9f55684cbf1f03ca706b1a05046c67c867d26ab737052da289527e243687b3dc85e4de3d68f9f64386a4022b5a9ae641d90eed169215f4ba56705"} 05:42:42 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:42 INFO - Copying logs to upload dir... 05:42:42 INFO - mkdir: /builds/slave/test/build/upload/logs 05:42:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.522349 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-22 05:42:42.318648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:42.322526) ========= 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=33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51ab2c34137797b834c835755cc4b173bf9478afda1498f89185a7b61c2e46c483011fba7721faadc3849ee340240ef1f4e9ec6ae915ba82d4bb1e9936477290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb76a75f8eb9f55684cbf1f03ca706b1a05046c67c867d26ab737052da289527e243687b3dc85e4de3d68f9f64386a4022b5a9ae641d90eed169215f4ba56705"} build_url:https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/cAM0zGTSRnSwE4FkF7A_NA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51ab2c34137797b834c835755cc4b173bf9478afda1498f89185a7b61c2e46c483011fba7721faadc3849ee340240ef1f4e9ec6ae915ba82d4bb1e9936477290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb76a75f8eb9f55684cbf1f03ca706b1a05046c67c867d26ab737052da289527e243687b3dc85e4de3d68f9f64386a4022b5a9ae641d90eed169215f4ba56705"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:42.347560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:42.348029) ========= 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=33d5923976266a1c518c4bf7000001ab-1461327735.198204-861408423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004713 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:42.428952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 05:42:42.429283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 05:42:42.429580) ========= ========= Total master_lag: 0.15 =========