builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1462925153.53 results: success (0) buildid: 20160510143005 builduid: d38a9ff5277f46c6b233f3622135e4df revision: ee562525573f8896fe4f7a5ac053de3d97ae4ccb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:53.533516) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:53.534057) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:53.534407) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:53.552290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:53.552782) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 17:05:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.9M=0s 2016-05-10 17:05:54 (40.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111680 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:53.678556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:53.678924) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015172 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:53.730567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:53.731059) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ee562525573f8896fe4f7a5ac053de3d97ae4ccb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ee562525573f8896fe4f7a5ac053de3d97ae4ccb --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=9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 17:05:54,922 truncating revision to first 12 chars 2016-05-10 17:05:54,922 Setting DEBUG logging. 2016-05-10 17:05:54,922 attempt 1/10 2016-05-10 17:05:54,922 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ee562525573f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 17:05:55,373 unpacking tar archive at: fx-team-ee562525573f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.785439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:54.529988) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:54.530355) ========= script_repo_revision: ee562525573f8896fe4f7a5ac053de3d97ae4ccb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:54.530893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:54.531320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 17:05:54.541979) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-10 17:05:54.542324) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:05:55 INFO - MultiFileLogger online at 20160510 17:05:55 in /builds/slave/test 17:05:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:05:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:05:55 INFO - {'append_to_log': False, 17:05:55 INFO - 'base_work_dir': '/builds/slave/test', 17:05:55 INFO - 'blob_upload_branch': 'Fx-Team', 17:05:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:05:55 INFO - 'branch': 'Fx-Team', 17:05:55 INFO - 'buildbot_json_path': 'buildprops.json', 17:05:55 INFO - 'config_files': ('talos/linux_config.py',), 17:05:55 INFO - 'default_actions': ('clobber', 17:05:55 INFO - 'read-buildbot-config', 17:05:55 INFO - 'download-and-extract', 17:05:55 INFO - 'populate-webroot', 17:05:55 INFO - 'create-virtualenv', 17:05:55 INFO - 'install', 17:05:55 INFO - 'run-tests'), 17:05:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:05:55 INFO - 'download_minidump_stackwalk': True, 17:05:55 INFO - 'download_symbols': 'ondemand', 17:05:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:05:55 INFO - 'tooltool.py': '/tools/tooltool.py', 17:05:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:05:55 INFO - '/tools/misc-python/virtualenv.py')}, 17:05:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:05:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:05:55 INFO - 'installer_path': 'installer.exe', 17:05:55 INFO - 'log_level': 'info', 17:05:55 INFO - 'log_name': 'talos', 17:05:55 INFO - 'log_to_console': True, 17:05:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:05:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:05:55 INFO - 'opt_config_files': (), 17:05:55 INFO - 'pip_index': False, 17:05:55 INFO - 'sps_profile': False, 17:05:55 INFO - 'sps_profile_interval': 0, 17:05:55 INFO - 'suite': 'dromaeojs-e10s', 17:05:55 INFO - 'system_bits': '32', 17:05:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:05:55 INFO - 'title': 'talos-linux64-ix-022', 17:05:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:05:55 INFO - 'use_talos_json': True, 17:05:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:05:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:05:55 INFO - 'work_dir': 'build'} 17:05:55 INFO - ##### 17:05:55 INFO - ##### Running clobber step. 17:05:55 INFO - ##### 17:05:55 INFO - Running pre-action listener: _resource_record_pre_action 17:05:55 INFO - Running main action method: clobber 17:05:55 INFO - rmtree: /builds/slave/test/build 17:05:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:05:56 INFO - Running post-action listener: _resource_record_post_action 17:05:56 INFO - ##### 17:05:56 INFO - ##### Finished clobber step (success) 17:05:56 INFO - ##### 17:05:56 INFO - ##### 17:05:56 INFO - ##### Running read-buildbot-config step. 17:05:56 INFO - ##### 17:05:56 INFO - Running pre-action listener: _resource_record_pre_action 17:05:56 INFO - Running main action method: read_buildbot_config 17:05:56 INFO - Using buildbot properties: 17:05:56 INFO - { 17:05:56 INFO - "project": "", 17:05:56 INFO - "product": "firefox", 17:05:56 INFO - "script_repo_revision": "production", 17:05:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:05:56 INFO - "repository": "", 17:05:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:05:56 INFO - "buildid": "20160510143005", 17:05:56 INFO - "pgo_build": "True", 17:05:56 INFO - "basedir": "/builds/slave/test", 17:05:56 INFO - "buildnumber": 308, 17:05:56 INFO - "slavename": "talos-linux64-ix-022", 17:05:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:05:56 INFO - "platform": "ubuntu64_hw", 17:05:56 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:05:56 INFO - "branch": "fx-team", 17:05:56 INFO - "repo_path": "integration/fx-team", 17:05:56 INFO - "revision": "ee562525573f8896fe4f7a5ac053de3d97ae4ccb", 17:05:56 INFO - "stage_platform": "linux64-pgo", 17:05:56 INFO - "builduid": "d38a9ff5277f46c6b233f3622135e4df", 17:05:56 INFO - "slavebuilddir": "test" 17:05:56 INFO - } 17:05:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:05:56 INFO - Running post-action listener: _resource_record_post_action 17:05:56 INFO - ##### 17:05:56 INFO - ##### Finished read-buildbot-config step (success) 17:05:56 INFO - ##### 17:05:56 INFO - ##### 17:05:56 INFO - ##### Running download-and-extract step. 17:05:56 INFO - ##### 17:05:56 INFO - Running pre-action listener: _resource_record_pre_action 17:05:56 INFO - Running main action method: download_and_extract 17:05:56 INFO - mkdir: /builds/slave/test/build/tests 17:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:56 INFO - https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:05:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:05:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:05:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:05:58 INFO - Downloaded 1361 bytes. 17:05:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:05:58 INFO - Using the following test package requirements: 17:05:58 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:05:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:05:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:05:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:58 INFO - u'jsshell-linux-x86_64.zip'], 17:05:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:05:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:05:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:05:58 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:05:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:05:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:05:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:58 INFO - https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:05:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:05:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:05:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:00 INFO - Downloaded 23898689 bytes. 17:06:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:06:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:06:01 INFO - Return code: 0 17:06:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:06:01 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')]} 17:06:01 INFO - https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:11 INFO - Downloaded 23898689 bytes. 17:06:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:06:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:06:12 INFO - Return code: 0 17:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:12 INFO - https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:06:14 INFO - Downloaded 10840152 bytes. 17:06:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:06:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:06:14 INFO - Return code: 0 17:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:14 INFO - https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:06:15 INFO - Downloaded 58352588 bytes. 17:06:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:15 INFO - mkdir: /builds/slave/test/properties 17:06:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:15 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:15 INFO - Contents: 17:06:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:16 INFO - Running post-action listener: _resource_record_post_action 17:06:16 INFO - Running post-action listener: set_extra_try_arguments 17:06:16 INFO - ##### 17:06:16 INFO - ##### Finished download-and-extract step (success) 17:06:16 INFO - ##### 17:06:16 INFO - ##### 17:06:16 INFO - ##### Running populate-webroot step. 17:06:16 INFO - ##### 17:06:16 INFO - Running pre-action listener: _resource_record_pre_action 17:06:16 INFO - Running main action method: populate_webroot 17:06:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:16 INFO - '--tppagecycles', 17:06:16 INFO - '7'], 17:06:16 INFO - 'tests': ['tsvgm']}}, 17:06:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:06:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:06:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:06:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:16 INFO - 'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:16 INFO - 'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['damp', 'tps']}, 17:06:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:16 INFO - 'tests': ['damp', 'tps']}, 17:06:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['dromaeo_dom']}, 17:06:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['a11yr', 17:06:16 INFO - 'ts_paint', 17:06:16 INFO - 'tpaint', 17:06:16 INFO - 'sessionrestore', 17:06:16 INFO - 'sessionrestore_no_auto_restore', 17:06:16 INFO - 'tabpaint']}, 17:06:16 INFO - 'other-e10s': {'tests': ['a11yr', 17:06:16 INFO - 'ts_paint', 17:06:16 INFO - 'tpaint', 17:06:16 INFO - 'sessionrestore', 17:06:16 INFO - 'sessionrestore_no_auto_restore', 17:06:16 INFO - 'tabpaint']}, 17:06:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:06:16 INFO - 'ts_paint', 17:06:16 INFO - 'tpaint', 17:06:16 INFO - 'sessionrestore', 17:06:16 INFO - 'sessionrestore_no_auto_restore', 17:06:16 INFO - 'tabpaint']}, 17:06:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:06:16 INFO - 'ts_paint', 17:06:16 INFO - 'tpaint', 17:06:16 INFO - 'sessionrestore', 17:06:16 INFO - 'sessionrestore_no_auto_restore', 17:06:16 INFO - 'tabpaint']}, 17:06:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['a11yr', 17:06:16 INFO - 'ts_paint', 17:06:16 INFO - 'tpaint', 17:06:16 INFO - 'sessionrestore', 17:06:16 INFO - 'sessionrestore_no_auto_restore', 17:06:16 INFO - 'tabpaint']}, 17:06:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['a11yr', 17:06:16 INFO - 'ts_paint', 17:06:16 INFO - 'tpaint', 17:06:16 INFO - 'sessionrestore', 17:06:16 INFO - 'sessionrestore_no_auto_restore', 17:06:16 INFO - 'tabpaint']}, 17:06:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['tsvgx', 17:06:16 INFO - 'tsvgr_opacity', 17:06:16 INFO - 'tart', 17:06:16 INFO - 'tscrollx', 17:06:16 INFO - 'cart']}, 17:06:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:06:16 INFO - 'tsvgr_opacity', 17:06:16 INFO - 'tart', 17:06:16 INFO - 'tscrollx', 17:06:16 INFO - 'cart']}, 17:06:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:16 INFO - 'talos_options': ['--disable-e10s'], 17:06:16 INFO - 'tests': ['tp5o']}, 17:06:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:16 INFO - 'tests': ['tp5o']}, 17:06:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:16 INFO - 'talos_options': ['--disable-e10s', 17:06:16 INFO - '--xperf_path', 17:06:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:16 INFO - 'tests': ['tp5n']}, 17:06:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:16 INFO - 'talos_options': ['--xperf_path', 17:06:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:16 INFO - 'tests': ['tp5n']}}, 17:06:16 INFO - 'talos.zip': {'path': '', 17:06:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:16 INFO - Running post-action listener: _resource_record_post_action 17:06:16 INFO - ##### 17:06:16 INFO - ##### Finished populate-webroot step (success) 17:06:16 INFO - ##### 17:06:16 INFO - ##### 17:06:16 INFO - ##### Running create-virtualenv step. 17:06:16 INFO - ##### 17:06:16 INFO - Running pre-action listener: _resource_record_pre_action 17:06:16 INFO - Running main action method: create_virtualenv 17:06:16 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:16 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 17:06:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:16 INFO - Using real prefix '/usr' 17:06:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:17 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:19 INFO - Installing pip.................done. 17:06:19 INFO - Return code: 0 17:06:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:19 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 0x7ff212ee7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', '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 17:06:19 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 17:06:19 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 17:06:19 INFO - Using env: {'DISPLAY': ':0', 17:06:19 INFO - 'HOME': '/home/cltbld', 17:06:19 INFO - 'LANG': 'en_US.UTF-8', 17:06:19 INFO - 'LANGUAGE': 'en_US:en', 17:06:19 INFO - 'LOGNAME': 'cltbld', 17:06:19 INFO - 'MAIL': '/var/mail/cltbld', 17:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:19 INFO - 'MOZ_NO_REMOTE': '1', 17:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:19 INFO - 'NO_EM_RESTART': '1', 17:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:19 INFO - 'PWD': '/builds/slave/test', 17:06:19 INFO - 'SHELL': '/bin/bash', 17:06:19 INFO - 'SHLVL': '1', 17:06:19 INFO - 'TERM': 'linux', 17:06:19 INFO - 'TMOUT': '86400', 17:06:19 INFO - 'USER': 'cltbld', 17:06:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:19 INFO - '_': '/tools/buildbot/bin/python'} 17:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:19 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 17:06:19 INFO - Cleaning up... 17:06:19 INFO - Return code: 0 17:06:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:19 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 0x7ff212ee7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', '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 17:06:19 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 17:06:19 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 17:06:19 INFO - Using env: {'DISPLAY': ':0', 17:06:19 INFO - 'HOME': '/home/cltbld', 17:06:19 INFO - 'LANG': 'en_US.UTF-8', 17:06:19 INFO - 'LANGUAGE': 'en_US:en', 17:06:19 INFO - 'LOGNAME': 'cltbld', 17:06:19 INFO - 'MAIL': '/var/mail/cltbld', 17:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:19 INFO - 'MOZ_NO_REMOTE': '1', 17:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:19 INFO - 'NO_EM_RESTART': '1', 17:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:19 INFO - 'PWD': '/builds/slave/test', 17:06:19 INFO - 'SHELL': '/bin/bash', 17:06:19 INFO - 'SHLVL': '1', 17:06:19 INFO - 'TERM': 'linux', 17:06:19 INFO - 'TMOUT': '86400', 17:06:19 INFO - 'USER': 'cltbld', 17:06:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:19 INFO - '_': '/tools/buildbot/bin/python'} 17:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:19 INFO - Downloading/unpacking psutil>=0.7.1 17:06:19 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 17:06:19 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 17:06:19 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 17:06:19 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 17:06:19 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 17:06:19 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 17:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:21 INFO - Installing collected packages: psutil 17:06:21 INFO - Running setup.py install for psutil 17:06:21 INFO - building 'psutil._psutil_linux' extension 17:06:21 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 17:06:21 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 17:06:22 INFO - building 'psutil._psutil_posix' extension 17:06:22 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 17:06:22 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 17:06:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:22 INFO - Successfully installed psutil 17:06:22 INFO - Cleaning up... 17:06:22 INFO - Return code: 0 17:06:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:22 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 0x7ff212ee7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', '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 17:06:22 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 17:06:22 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 17:06:22 INFO - Using env: {'DISPLAY': ':0', 17:06:22 INFO - 'HOME': '/home/cltbld', 17:06:22 INFO - 'LANG': 'en_US.UTF-8', 17:06:22 INFO - 'LANGUAGE': 'en_US:en', 17:06:22 INFO - 'LOGNAME': 'cltbld', 17:06:22 INFO - 'MAIL': '/var/mail/cltbld', 17:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:22 INFO - 'MOZ_NO_REMOTE': '1', 17:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:22 INFO - 'NO_EM_RESTART': '1', 17:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:22 INFO - 'PWD': '/builds/slave/test', 17:06:22 INFO - 'SHELL': '/bin/bash', 17:06:22 INFO - 'SHLVL': '1', 17:06:22 INFO - 'TERM': 'linux', 17:06:22 INFO - 'TMOUT': '86400', 17:06:22 INFO - 'USER': 'cltbld', 17:06:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:22 INFO - '_': '/tools/buildbot/bin/python'} 17:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:06:24 INFO - Installing collected packages: mozsystemmonitor 17:06:24 INFO - Running setup.py install for mozsystemmonitor 17:06:24 INFO - Successfully installed mozsystemmonitor 17:06:24 INFO - Cleaning up... 17:06:24 INFO - Return code: 0 17:06:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:06:24 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')]} 17:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:24 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')]} 17:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:24 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 0x7ff212ee7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', '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 17:06:24 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 17:06:24 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 17:06:24 INFO - Using env: {'DISPLAY': ':0', 17:06:24 INFO - 'HOME': '/home/cltbld', 17:06:24 INFO - 'LANG': 'en_US.UTF-8', 17:06:24 INFO - 'LANGUAGE': 'en_US:en', 17:06:24 INFO - 'LOGNAME': 'cltbld', 17:06:24 INFO - 'MAIL': '/var/mail/cltbld', 17:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:24 INFO - 'MOZ_NO_REMOTE': '1', 17:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:24 INFO - 'NO_EM_RESTART': '1', 17:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:24 INFO - 'PWD': '/builds/slave/test', 17:06:24 INFO - 'SHELL': '/bin/bash', 17:06:24 INFO - 'SHLVL': '1', 17:06:24 INFO - 'TERM': 'linux', 17:06:24 INFO - 'TMOUT': '86400', 17:06:24 INFO - 'USER': 'cltbld', 17:06:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:24 INFO - '_': '/tools/buildbot/bin/python'} 17:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:24 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:24 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 17:06:24 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 17:06:24 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 17:06:24 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 17:06:24 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 17:06:24 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 17:06:26 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:26 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 17:06:26 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 17:06:26 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 17:06:26 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 17:06:26 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 17:06:26 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 17:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:27 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 17:06:27 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 17:06:27 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 17:06:27 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 17:06:27 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 17:06:27 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 17:06:27 INFO - Downloading docopt-0.6.1.tar.gz 17:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:27 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:27 INFO - Running setup.py install for blobuploader 17:06:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:27 INFO - Running setup.py install for requests 17:06:27 INFO - Running setup.py install for docopt 17:06:27 INFO - Successfully installed blobuploader requests docopt 17:06:27 INFO - Cleaning up... 17:06:28 INFO - Return code: 0 17:06:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:28 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')]} 17:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:28 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')]} 17:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:28 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 0x7ff212ee7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', '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 17:06:28 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 17:06:28 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 17:06:28 INFO - Using env: {'DISPLAY': ':0', 17:06:28 INFO - 'HOME': '/home/cltbld', 17:06:28 INFO - 'LANG': 'en_US.UTF-8', 17:06:28 INFO - 'LANGUAGE': 'en_US:en', 17:06:28 INFO - 'LOGNAME': 'cltbld', 17:06:28 INFO - 'MAIL': '/var/mail/cltbld', 17:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:28 INFO - 'MOZ_NO_REMOTE': '1', 17:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:28 INFO - 'NO_EM_RESTART': '1', 17:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:28 INFO - 'PWD': '/builds/slave/test', 17:06:28 INFO - 'SHELL': '/bin/bash', 17:06:28 INFO - 'SHLVL': '1', 17:06:28 INFO - 'TERM': 'linux', 17:06:28 INFO - 'TMOUT': '86400', 17:06:28 INFO - 'USER': 'cltbld', 17:06:28 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:28 INFO - '_': '/tools/buildbot/bin/python'} 17:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:28 INFO - Running setup.py (path:/tmp/pip-sJ06NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:28 INFO - Running setup.py (path:/tmp/pip-fU_nIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:28 INFO - Running setup.py (path:/tmp/pip-DtfbVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:28 INFO - Running setup.py (path:/tmp/pip-bbZ33C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:28 INFO - Running setup.py (path:/tmp/pip-tfBYxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:28 INFO - Running setup.py (path:/tmp/pip-RE71Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:28 INFO - Running setup.py (path:/tmp/pip-m0h0TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:28 INFO - Running setup.py (path:/tmp/pip-GCTjdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:28 INFO - Running setup.py (path:/tmp/pip-xuqXfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:28 INFO - Running setup.py (path:/tmp/pip-8IJXhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:29 INFO - Running setup.py (path:/tmp/pip-XNZW6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:29 INFO - Running setup.py (path:/tmp/pip-BTLfT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:29 INFO - Running setup.py (path:/tmp/pip-Te7IIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:29 INFO - Running setup.py (path:/tmp/pip-POxgPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:29 INFO - Running setup.py (path:/tmp/pip-S9Cunv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:29 INFO - Running setup.py (path:/tmp/pip-Rvkcm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:29 INFO - Running setup.py (path:/tmp/pip-Uh0XJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:29 INFO - Running setup.py install for manifestparser 17:06:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:29 INFO - Running setup.py install for mozcrash 17:06:29 INFO - Running setup.py install for mozdebug 17:06:29 INFO - Running setup.py install for mozdevice 17:06:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:06:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:29 INFO - Running setup.py install for mozfile 17:06:30 INFO - Running setup.py install for mozhttpd 17:06:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Running setup.py install for mozinfo 17:06:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Running setup.py install for mozInstall 17:06:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Running setup.py install for mozleak 17:06:30 INFO - Running setup.py install for mozlog 17:06:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Running setup.py install for moznetwork 17:06:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Running setup.py install for mozprocess 17:06:30 INFO - Running setup.py install for mozprofile 17:06:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Running setup.py install for mozrunner 17:06:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:30 INFO - Running setup.py install for mozscreenshot 17:06:31 INFO - Running setup.py install for moztest 17:06:31 INFO - Running setup.py install for mozversion 17:06:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:31 INFO - Cleaning up... 17:06:31 INFO - Return code: 0 17:06:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:31 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 0x7ff212ee7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', '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 17:06:31 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 17:06:31 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 17:06:31 INFO - Using env: {'DISPLAY': ':0', 17:06:31 INFO - 'HOME': '/home/cltbld', 17:06:31 INFO - 'LANG': 'en_US.UTF-8', 17:06:31 INFO - 'LANGUAGE': 'en_US:en', 17:06:31 INFO - 'LOGNAME': 'cltbld', 17:06:31 INFO - 'MAIL': '/var/mail/cltbld', 17:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:31 INFO - 'MOZ_NO_REMOTE': '1', 17:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:31 INFO - 'NO_EM_RESTART': '1', 17:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:31 INFO - 'PWD': '/builds/slave/test', 17:06:31 INFO - 'SHELL': '/bin/bash', 17:06:31 INFO - 'SHLVL': '1', 17:06:31 INFO - 'TERM': 'linux', 17:06:31 INFO - 'TMOUT': '86400', 17:06:31 INFO - 'USER': 'cltbld', 17:06:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:31 INFO - '_': '/tools/buildbot/bin/python'} 17:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:31 INFO - Running setup.py (path:/tmp/pip-ujEb6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:31 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)) 17:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:31 INFO - Running setup.py (path:/tmp/pip-66Eck3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:31 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)) 17:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:31 INFO - Running setup.py (path:/tmp/pip-h8txuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:31 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)) 17:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:31 INFO - Running setup.py (path:/tmp/pip-QQHQsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:31 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)) 17:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:31 INFO - Running setup.py (path:/tmp/pip-gNLIqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:31 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)) 17:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:31 INFO - Running setup.py (path:/tmp/pip-OIYfgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:31 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)) 17:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:31 INFO - Running setup.py (path:/tmp/pip-QwTdWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:32 INFO - Running setup.py (path:/tmp/pip-gH7xFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:32 INFO - Running setup.py (path:/tmp/pip-Pa0JqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:32 INFO - Running setup.py (path:/tmp/pip-WcN3Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:32 INFO - Running setup.py (path:/tmp/pip-4Z0jwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:32 INFO - Running setup.py (path:/tmp/pip-aHTrIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:32 INFO - Running setup.py (path:/tmp/pip-srKhRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:32 INFO - Running setup.py (path:/tmp/pip-FfUiQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:32 INFO - Running setup.py (path:/tmp/pip-Zo4fad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:32 INFO - Running setup.py (path:/tmp/pip-tCwErz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:32 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)) 17:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:32 INFO - Running setup.py (path:/tmp/pip-6NN3ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:32 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)) 17:06:32 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)) 17:06:32 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)) 17:06:32 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)) 17:06:32 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)) 17:06:32 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)) 17:06:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:34 INFO - Downloading blessings-1.6.tar.gz 17:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:34 INFO - Installing collected packages: blessings 17:06:34 INFO - Running setup.py install for blessings 17:06:34 INFO - Successfully installed blessings 17:06:34 INFO - Cleaning up... 17:06:34 INFO - Return code: 0 17:06:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:06:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:35 INFO - Reading from file tmpfile_stdout 17:06:35 INFO - Current package versions: 17:06:35 INFO - argparse == 1.2.1 17:06:35 INFO - blessings == 1.6 17:06:35 INFO - blobuploader == 1.2.4 17:06:35 INFO - docopt == 0.6.1 17:06:35 INFO - manifestparser == 1.1 17:06:35 INFO - mozInstall == 1.12 17:06:35 INFO - mozcrash == 0.17 17:06:35 INFO - mozdebug == 0.1 17:06:35 INFO - mozdevice == 0.48 17:06:35 INFO - mozfile == 1.2 17:06:35 INFO - mozhttpd == 0.7 17:06:35 INFO - mozinfo == 0.9 17:06:35 INFO - mozleak == 0.1 17:06:35 INFO - mozlog == 3.1 17:06:35 INFO - moznetwork == 0.27 17:06:35 INFO - mozprocess == 0.22 17:06:35 INFO - mozprofile == 0.28 17:06:35 INFO - mozrunner == 6.11 17:06:35 INFO - mozscreenshot == 0.1 17:06:35 INFO - mozsystemmonitor == 0.0 17:06:35 INFO - moztest == 0.7 17:06:35 INFO - mozversion == 1.4 17:06:35 INFO - psutil == 3.1.1 17:06:35 INFO - requests == 1.2.3 17:06:35 INFO - wsgiref == 0.1.2 17:06:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:35 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')]} 17:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:35 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')]} 17:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:35 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 0x7ff212ee7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', '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 17:06:35 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 17:06:35 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 17:06:35 INFO - Using env: {'DISPLAY': ':0', 17:06:35 INFO - 'HOME': '/home/cltbld', 17:06:35 INFO - 'LANG': 'en_US.UTF-8', 17:06:35 INFO - 'LANGUAGE': 'en_US:en', 17:06:35 INFO - 'LOGNAME': 'cltbld', 17:06:35 INFO - 'MAIL': '/var/mail/cltbld', 17:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:35 INFO - 'MOZ_NO_REMOTE': '1', 17:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:35 INFO - 'NO_EM_RESTART': '1', 17:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:35 INFO - 'PWD': '/builds/slave/test', 17:06:35 INFO - 'SHELL': '/bin/bash', 17:06:35 INFO - 'SHLVL': '1', 17:06:35 INFO - 'TERM': 'linux', 17:06:35 INFO - 'TMOUT': '86400', 17:06:35 INFO - 'USER': 'cltbld', 17:06:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:35 INFO - '_': '/tools/buildbot/bin/python'} 17:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 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)) 17:06:35 INFO - Cleaning up... 17:06:35 INFO - Return code: 0 17:06:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:06:35 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')]} 17:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:35 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')]} 17:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:35 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 0x7ff212ee7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', '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 17:06:35 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 17:06:35 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 17:06:35 INFO - Using env: {'DISPLAY': ':0', 17:06:35 INFO - 'HOME': '/home/cltbld', 17:06:35 INFO - 'LANG': 'en_US.UTF-8', 17:06:35 INFO - 'LANGUAGE': 'en_US:en', 17:06:35 INFO - 'LOGNAME': 'cltbld', 17:06:35 INFO - 'MAIL': '/var/mail/cltbld', 17:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:35 INFO - 'MOZ_NO_REMOTE': '1', 17:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:35 INFO - 'NO_EM_RESTART': '1', 17:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:35 INFO - 'PWD': '/builds/slave/test', 17:06:35 INFO - 'SHELL': '/bin/bash', 17:06:35 INFO - 'SHLVL': '1', 17:06:35 INFO - 'TERM': 'linux', 17:06:35 INFO - 'TMOUT': '86400', 17:06:35 INFO - 'USER': 'cltbld', 17:06:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:35 INFO - '_': '/tools/buildbot/bin/python'} 17:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:35 INFO - Downloading/unpacking jsonschema 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:06:37 INFO - Downloading/unpacking functools32 (from jsonschema) 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:37 INFO - Downloading functools32-3.2.3-2.tar.gz 17:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:06:37 INFO - warning: no files found matching '*.txt' 17:06:37 INFO - no previously-included directories found matching 'build' 17:06:37 INFO - no previously-included directories found matching 'dist' 17:06:37 INFO - no previously-included directories found matching '.git*' 17:06:37 INFO - Installing collected packages: jsonschema, functools32 17:06:37 INFO - Running setup.py install for functools32 17:06:37 INFO - warning: no files found matching '*.txt' 17:06:37 INFO - no previously-included directories found matching 'build' 17:06:37 INFO - no previously-included directories found matching 'dist' 17:06:37 INFO - no previously-included directories found matching '.git*' 17:06:37 INFO - Successfully installed jsonschema functools32 17:06:37 INFO - Cleaning up... 17:06:37 INFO - Return code: 0 17:06:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff212ee7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', '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 17:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:06:37 INFO - Using env: {'DISPLAY': ':0', 17:06:37 INFO - 'HOME': '/home/cltbld', 17:06:37 INFO - 'LANG': 'en_US.UTF-8', 17:06:37 INFO - 'LANGUAGE': 'en_US:en', 17:06:37 INFO - 'LOGNAME': 'cltbld', 17:06:37 INFO - 'MAIL': '/var/mail/cltbld', 17:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:37 INFO - 'MOZ_NO_REMOTE': '1', 17:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:37 INFO - 'NO_EM_RESTART': '1', 17:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:37 INFO - 'PWD': '/builds/slave/test', 17:06:37 INFO - 'SHELL': '/bin/bash', 17:06:37 INFO - 'SHLVL': '1', 17:06:37 INFO - 'TERM': 'linux', 17:06:37 INFO - 'TMOUT': '86400', 17:06:37 INFO - 'USER': 'cltbld', 17:06:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:37 INFO - '_': '/tools/buildbot/bin/python'} 17:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:38 INFO - Downloading/unpacking flake8 17:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:06:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:06:39 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 17:06:39 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 17:06:39 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 17:06:39 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 17:06:39 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 17:06:39 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 17:06:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:06:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:06:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:06:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:06:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:06:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:06:40 INFO - no previously-included directories found matching 'docs/_build' 17:06:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:06:40 INFO - Running setup.py install for pep8 17:06:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:06:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:06:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:06:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:06:40 INFO - no previously-included directories found matching 'docs/_build' 17:06:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:06:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:06:40 INFO - Cleaning up... 17:06:40 INFO - Return code: 0 17:06:40 INFO - Running post-action listener: _resource_record_post_action 17:06:40 INFO - Running post-action listener: _start_resource_monitoring 17:06:40 INFO - Starting resource monitoring. 17:06:40 INFO - ##### 17:06:40 INFO - ##### Finished create-virtualenv step (success) 17:06:40 INFO - ##### 17:06:40 INFO - ##### 17:06:40 INFO - ##### Running install step. 17:06:40 INFO - ##### 17:06:40 INFO - Running pre-action listener: _resource_record_pre_action 17:06:40 INFO - Running main action method: install 17:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:41 INFO - Reading from file tmpfile_stdout 17:06:41 INFO - Detecting whether we're running mozinstall >=1.0... 17:06:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:06:41 INFO - Reading from file tmpfile_stdout 17:06:41 INFO - Output received: 17:06:41 INFO - Usage: mozinstall [options] installer 17:06:41 INFO - Options: 17:06:41 INFO - -h, --help show this help message and exit 17:06:41 INFO - -d DEST, --destination=DEST 17:06:41 INFO - Directory to install application into. [default: 17:06:41 INFO - "/builds/slave/test"] 17:06:41 INFO - --app=APP Application being installed. [default: firefox] 17:06:41 INFO - mkdir: /builds/slave/test/build/application 17:06:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:06:57 INFO - Reading from file tmpfile_stdout 17:06:57 INFO - Output received: 17:06:57 INFO - /builds/slave/test/build/application/firefox/firefox 17:06:57 INFO - Running post-action listener: _resource_record_post_action 17:06:57 INFO - ##### 17:06:57 INFO - ##### Finished install step (success) 17:06:57 INFO - ##### 17:06:57 INFO - ##### 17:06:57 INFO - ##### Running run-tests step. 17:06:57 INFO - ##### 17:06:57 INFO - Running pre-action listener: _resource_record_pre_action 17:06:57 INFO - Running main action method: run_tests 17:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:06:57 INFO - Python 2.7.3 17:06:57 INFO - Return code: 0 17:06:57 INFO - grabbing minidump binary from tooltool 17:06:57 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')]} 17:06:57 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 0x1d9f9c0>, '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 0x1da08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:06:57 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 17:06:57 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 17:06:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:06:57 INFO - Return code: 0 17:06:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:06:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:06:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:06:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:06:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:06:58 INFO - Return code: 0 17:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 17:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 17:06:58 INFO - Using env: {'DISPLAY': ':0', 17:06:58 INFO - 'HOME': '/home/cltbld', 17:06:58 INFO - 'LANG': 'en_US.UTF-8', 17:06:58 INFO - 'LANGUAGE': 'en_US:en', 17:06:58 INFO - 'LOGNAME': 'cltbld', 17:06:58 INFO - 'MAIL': '/var/mail/cltbld', 17:06:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:06:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:58 INFO - 'MOZ_NO_REMOTE': '1', 17:06:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:58 INFO - 'NO_EM_RESTART': '1', 17:06:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:58 INFO - 'PWD': '/builds/slave/test', 17:06:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:06:58 INFO - 'SHELL': '/bin/bash', 17:06:58 INFO - 'SHLVL': '1', 17:06:58 INFO - 'TERM': 'linux', 17:06:58 INFO - 'TMOUT': '86400', 17:06:58 INFO - 'USER': 'cltbld', 17:06:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364', 17:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:58 INFO - '_': '/tools/buildbot/bin/python'} 17:06:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 17:06:59 INFO - mozversion application_buildid: 20160510143005 17:06:59 INFO - mozversion application_changeset: ee562525573f8896fe4f7a5ac053de3d97ae4ccb 17:06:59 INFO - mozversion application_display_name: Nightly 17:06:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:06:59 INFO - mozversion application_name: Firefox 17:06:59 INFO - mozversion application_remotingname: firefox 17:06:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:06:59 INFO - mozversion application_vendor: Mozilla 17:06:59 INFO - mozversion application_version: 49.0a1 17:06:59 INFO - mozversion platform_buildid: 20160510143005 17:06:59 INFO - mozversion platform_changeset: ee562525573f8896fe4f7a5ac053de3d97ae4ccb 17:06:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:06:59 INFO - mozversion platform_version: 49.0a1 17:06:59 INFO - using testdate: 1462925219 17:06:59 INFO - actual date: 1462925219 17:06:59 INFO - starting webserver on 'localhost:38137' 17:06:59 INFO - SUITE-START | Running 2 tests 17:06:59 INFO - TEST-START | dromaeo_css 17:06:59 INFO - operating with platform_type : linux_ 17:06:59 INFO - Initialising browser for dromaeo_css test... 17:06:59 INFO - TEST-INFO | started process 566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9dcOWG/profile http://localhost:38137/getInfo.html) 17:07:02 INFO - PROCESS | 566 | 17:07:02 INFO - PROCESS | 566 | (process:634): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:07:03 INFO - PROCESS | 566 | __metrics Screen width/height:1600/1200 17:07:03 INFO - PROCESS | 566 | colorDepth:24 17:07:03 INFO - PROCESS | 566 | Browser inner width/height: 1024/697 17:07:03 INFO - PROCESS | 566 | __metrics 17:07:04 ERROR - PROCESS | 566 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:07:05 INFO - TEST-INFO | 566: exit 0 17:07:05 INFO - Browser initialized. 17:07:05 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:05 INFO - TEST-INFO | started process 686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9dcOWG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:07 INFO - PROCESS | 686 | 17:07:07 INFO - PROCESS | 686 | (process:749): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:07:17 INFO - PROCESS | 686 | RSS: Main: 163151872 17:07:17 INFO - PROCESS | 686 | 17:08:07 INFO - PROCESS | 686 | 1462925287006 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] 17:10:15 INFO - PROCESS | 686 | Cycle 1(1): loaded http://localhost:38137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38137/tests/dromaeo/cssquery-ext.html) 17:10:16 INFO - PROCESS | 686 | RSS: Main: 167194624 17:10:16 INFO - PROCESS | 686 | 17:13:18 INFO - PROCESS | 686 | Cycle 1(1): loaded http://localhost:38137/tests/dromaeo/cssquery-ext.html (next: http://localhost:38137/tests/dromaeo/cssquery-jquery.html) 17:13:18 INFO - PROCESS | 686 | RSS: Main: 166830080 17:13:18 INFO - PROCESS | 686 | 17:16:20 INFO - PROCESS | 686 | Cycle 1(1): loaded http://localhost:38137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38137/tests/dromaeo/cssquery-mootools.html) 17:16:21 INFO - PROCESS | 686 | RSS: Main: 167600128 17:16:21 INFO - PROCESS | 686 | 17:19:22 INFO - PROCESS | 686 | Cycle 1(1): loaded http://localhost:38137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38137/tests/dromaeo/cssquery-prototype.html) 17:19:23 INFO - PROCESS | 686 | RSS: Main: 165482496 17:19:23 INFO - PROCESS | 686 | 17:22:25 INFO - PROCESS | 686 | Cycle 1(1): loaded http://localhost:38137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38137/tests/dromaeo/cssquery-yui.html) 17:22:26 INFO - PROCESS | 686 | RSS: Main: 166367232 17:22:26 INFO - PROCESS | 686 | 17:25:29 INFO - PROCESS | 686 | Cycle 1(1): loaded http://localhost:38137/tests/dromaeo/cssquery-yui.html (next: http://localhost:38137/tests/dromaeo/cssquery-dojo.html) 17:25:29 INFO - PROCESS | 686 | RSS: Main: 168636416 17:25:29 INFO - PROCESS | 686 | 17:25:29 INFO - PROCESS | 686 | __start_tp_report 17:25:29 INFO - PROCESS | 686 | _x_x_mozilla_page_load 17:25:29 INFO - PROCESS | 686 | _x_x_mozilla_page_load_details 17:25:29 INFO - PROCESS | 686 | |i|pagename|runs| 17:25:29 INFO - PROCESS | 686 | |0;dojo.html;3157.95263071054;3175.0950978971;3190.9680903190974;3195.7762956593047;3217.7104060634547;5465.781368745251;5478.0413427650155;5521.365043020054;5539.723013849311;5557.6109672322855;5418.187271909215;5511.366192887819;5517.779288828442;5519.69641669708;5592.804251851186;4877.658563900528;4909.484504127069;5081.136206844827;5096.235564665293;5102.953894451629;875.5770209924932;4829.90340193196;4972.627052971024;5024.196128619422;5117.1556693145585;4998;5006.123928312549;5010.799568017275;5049.166887463564;5070;5040.84877453677;5043.36957880265;5044.9495505045215;5045.142325804622;5047.974760126176;4805.327254184417;4961.5038496150455;4994.300797888299;5041.19340905457;5064.468230835783;5480.588955828289;5481.068218402841;5507.669539827623;5524.419935906712;5539.113741801292;5690.06113991191;6025.276966763972;6031.758729650809;6038.758449662008;6060.424259695322;5966;6028.216331876828;6031.366706495799;6044.486218671418;6066.090086487018;5663.801766938137;5673.489385955242;5681.687507187103;5683.573731970118;5687.374388817227;5915;6043.969780151159;6167.198264225622;6186.4741496972365;6187.628742275478;5829.650220986754;5908.291005079418;5917.408259174048;5923.378045305267;5959.970200148971;5984.820455386345;5989.580729348903;5991.370906054889;5991.64050156992;5995.340512543617;5747.827565173052;5859.501942334864;5910.083936989773;5946.197263369476;5963.4334738199805;5979.252593425822;5990.31111422192;6017.669028203491;6029.909551356734;6049.78825741097;4510.481294651091;4515.367848501212;4520.389747384061;4521.84173553924;4556.498785133633;3876.6317199865966;3925.862594809225;3978.8806335809973;3998.9800051000143;4003.3594624859884;5483.2049352844415;5569.10894256917;5584.329880414376;5613.270274864323;5653.773849046074;5977.312609049928;5999.640021598718;6002.309734380515;6006.579539432285;6007.429294217042;5431.592630552725;5563.805266815642;5597.832065038056;5605.047141985872;5679.062954612526;4894.926576101361;4908.754562271872;4909.018196360671;4923.335349727812;4965.776540055706;6084.421979911901;6102;6106.206193194945;6110.175126357974;6110.847228819226;5723.227364305765;5882.058870580858;5904.61619994699;5906.7341969612335;5984.760609575743;6134.907976380268;6137;6137.232845894263;6141.232345956755;6144.38556144382;5700.230468886647;5825.155352473783;5870.823875283749;5872.588918775645;5876.500497457764;5864.149698293638;5894.852628684317;5954.4343287389365;5985.760569577168;5995.1906492624685;5788.855278618068;5826.76692932278;5829.067349224104;5829.15477255804;5845.09401042839;5699.344575373885;5775.537956963517;5800.6809625471005;5801.796937107181;5808.419158084158;5733.31200255972;5754.9424505754405;5755.740991655469;5785.82642520725;5840.269966254218;5756.568257380797;5900.970495147497;5910.231669882888;5915.142304365929;5933.169356290036;5472.370677372153;5679.6024278301775;5719.942800572107;5794.449527294901;5805.10020946754 17:25:29 INFO - PROCESS | 686 | |1;ext.html;599.8620317327014;649.5907578225717;655.2137435077907;671.5534169777098;679.7790718016646;37756.81121594392;42655.57344426559;42668.14663706724;42819.78590107045;42845.14309713804;41590.58409415912;42108.15783684332;42170;42185;42193.156136877245;8700.347473939464;8814.691485798;8862.246709029709;8867.423617464845;8872.20150186483;8730.694425695103;8815.911840881574;8873.20141187293;8906.777330566756;8907;8883.644654213856;8905.020447750774;8908.465492070496;8924.776880577972;8936.195742383185;8875.467471951704;8914.687985920495;8939.195472407482;8960.059193784657;8967.596458159333;8752.299816014767;8854;8889.911100888972;8899.510526921016;8907;34055;38848.80575597132;38922.61077389218;39174.21651566981;39273.41089883654;3076.646185688652;3125.828079455629;3138.168385377877;3297.159224397787;3386.2888793353177;30400.695993040008;30902.22744431407;30920.536191957137;30943;32052.839735801404;3443.6212016678146;3536.8054756988354;3542.1852973815908;3550.946735798965;3579.069441945113;279777;443782;454407;456307;458857.9999999967;57201.427985720446;57593;57681.846363073346;57778.7111064442;57779;36566.63433365685;37542.812285938395;37687.246255074744;39523.80238098791;59688.40311596915;17619.383321583682;17625.884893812825;17701.46895593134;17703.38038168684;17709.38017169393;13909.165450073027;13911.373988170557;13922;13999.580012599637;14041.78937315941;19297.228110875687;19313.78527797487;19543.120559574854;19585.804141958684;19625.803741962398;7355.154157271875;7371.631418429057;7517;7535.397168226528;7665.23347665229;1043.3583346242158;1148.7128217945515;1218.1959906461693;1220.926744395339;1250.2436026204198;30630.234244144074;31198.22004449907;31381.37237255242;31592.684073159435;32037;1149.5918948773065;1225.2342286071205;1241.1312081542956;1316.7498175346655;1339.6316013096477;16680.49958501247;16942.322307107577;16986.490405287863;17122.91438542824;17128.143592820557;478801;482988;485157;486740;486779;57455.425445745845;57515;57610.71194644084;57760;57810.42189578134;1395.483671041721;1412.9293535323193;1420.666143456287;1443.336065409923;1444.8049513315777;29849.850750746107;30507.389852203276;30659.693403065685;30814.69185308118;31200.063998080095;49201.753991229816;49497;49972;50006.249906250705;50024.49975500198;376216;378283;378553;380256;380370;27832.582511261942;28301.57547636746;28304;29083.12750617485;29287.12138635844;46253;46461;46851.297230540884;47106.528934710215;47252.7637361811;40502.114640511776;40914.795426022676;40997;41326.586734132274;41808.37287440752;39291;39740.40389394104;40571.59428405796;40795.1840963185;40994;40051.79974100111;41269;42746.35880461733;42907.570924291605;45018.32472512849;29604.555931660612;32367.51448728318;32754.83622581872;34391.31217375689;34696.65303347035;25249.49501010006;26115.869420652776;26204.86897565576;26285.474290514467;26580.601290981038 17:25:29 INFO - PROCESS | 686 | |2;jquery.html;407.34417587683845;408.0349972315471;416.9916601667967;419.44214195120486;429.2595273153808;18042.639147217065;18988.905055474737;19672.409827705174;19674.606507869852;19894.40316790495;12537.185082969601;12893.097483176158;15170.469033583826;19573.217071317165;19688.310909118183;5295.4969277918535;5353.223782551528;5449.1826226066205;5461.508464238218;5704.1443783432405;5438.8912221755545;5593.300837395325;5609.607327487078;5664.518515926131;5666.320041595014;5849.824505264849;5901.439363260483;5905.261842269716;5930.051191809312;5938.732757025944;5691.9146212806845;5852.385499522553;5860.238169038041;5862.296524417097;5894.351621321651;5641.12562552805;5682.346530149044;5733.827985160452;5735.311762588516;5737.967165910134;13987.37056832445;18501.537461563435;22640.094396224133;23677.408064798346;23690.170844020377;2193.824494040473;2282.566312400655;2313.4910319729634;2437.744036876138;2456.4841383309526;10888.836667449994;10969.957854003856;13512.797308040388;14166.929165354108;14862.554123376316;1972.3984184823623;2031.8882461464614;2078.8306080977027;2078.844086693489;2091.0799248330836;81337.59331203366;84510;84878;94574.5271273646;96576.51711741467;11109.666709998713;11564.653060408033;11590.826137607773;11646.068314534818;11786.5874694387;16236.431724889571;16280.511584652479;16370.754438683429;16372.508824735278;16376;8565.957170214233;8688.78278043054;8756.693515726918;8856.24721898633;8929.374943754005;8411.663533458594;8415.074341822394;8470.449420787629;8483.83032339362;8824.338174636929;4935.802567897315;4940.629452790983;4979.726115063634;4989.480312442193;4997.075541024922;2040.5612793249522;2057.711920331155;2090.5818836232816;2101.779313172095;2114.587655407181;1034.1364960258118;1054.3673795722505;1082.9025387715144;1108.3626914524182;1109.7170221593603;18305.542361440803;19310.80689193118;19495.8050419494;20111;20180.495487612927;1028.2391030637275;1043.796459690353;1053.1259054984343;1059.502034043998;1061.9734506637396;9182.494962777111;11194.552217911192;11305.321680699184;11313;11369.147313951487;431400;433793;436987;464855;466044;96551;99869.50065249627;102229;103573.48213258885;104052.47973760082;1047.4448542272607;1053.3258714422775;1064.595453727594;1076.321917192164;1079.6491140379408;17301;17307.826921730622;17397.30410783605;17591.736123958406;17622.91188544049;42041;42333.36499952565;42758.78620606877;42831.57168428276;43019.56980430156;57931.71034144971;59029;60178;60400;60749.39250607437;8777.692780752643;9025.819483610423;9051;9303.209227215491;9514.762130946781;9401.529923503935;9993.600255989679;12660.746785064432;12929.54746583865;13069.738605228033;10497.685069447929;11034.613788517363;11088.279261847954;11137.832932505857;11139;11193.27243729155;11279.605213817476;11290.548378064785;11582.768344633228;11625.76748465009;9587.561865720198;11071.280366776135;11498.310101393943;11590.88409115898;12187.146899717289;9009.504477253551;9179.219766319937;9207.802985611828;9252.53737313145;9341.392809467363;9310.581023853807;12036.338001410006;12109.75780484403;12183.329916854658;12240.326782027074 17:25:29 INFO - PROCESS | 686 | |3;mootools.html;1534.2252162657855;1559.8518140776625;1772.3265159239488;1857.9721304180432;1885.4532185666158;7845;8836.425632333894;8887.377883548153;9427.245820334383;9453.96006439292;9050.773730656736;9072.274218062556;9094.045125261851;9150.679726209568;9159.45043297401;2401.6157414813633;2440.4996975619956;2441.9023239070507;2446.7675570820834;2448.24104527597;2348.9177878774244;2377.072941552796;2391.366287933699;2405.6271277951946;2409.1567951217107;2390.2231774673214;2399.940001499959;2412.2522018174336;2463.692038495188;2470.6170543565777;2140.5504843982703;2151.451379898124;2154.9353519394444;2167.5231449081175;2169.1865550418593;2285.5885940530698;2327.2320134355623;2327.4995875886766;2330.753047119783;2338.076459798387;9124.543772811332;9184.26525877935;9202.953985230031;9264.25885929124;9266.212371948392;5354.063038968165;5607.635503692247;5622.550195984311;5627.662340259557;5655.773769049233;3548.290341931598;3555.8933232003083;3589.335972845032;3658.067192865829;3683.4106542953;1065.8880817514128;1082.783443311341;1082.978340433187;1102.597551893561;1112.1603189591888;13095.672608184776;13129.540466083641;13136.868631313755;13204;13206.075574709774;4790.233562630032;4886.804527818847;4891.706497610155;4929.482404347564;4965.205567109245;10925.617603383844;10988.395638239814;10999.34003959765;11008.119350451945;11012.063974562092;5494.697791621419;5507.366652834975;5512.503874651301;5545.195946587723;5550.639208451518;4485.932711009337;4967.379077615298;5071.163258062452;5106.821261255913;5117.769700363493;4141.316682747313;4195.664346852244;4198.8110535026;4227.957720422818;4234.343676730112;1301.7136230029378;1357.5723647051148;1379.1793882639813;1385.819843420349;1389.6178550898583;991.4002028772633;998.9051040151174;1001.929864909464;1006.5571148694551;1014.8122597319372;6021.849453763691;6025.367336429699;6037.969810151009;6047.3045599755715;6251.031090181029;475.23724422301706;476.17621514779626;479.25715141530486;485.4975100770685;489.0561216851511;4004.9599504004586;4040.6363427291685;4070.531888832763;4093.713440059167;4180.602842729936;10780.78438431227;11208.495617697223;11297.71755706114;11521.251118677259;11589.594364197214;11326.660200194008;11349.602763903224;11429.828552571718;11439.313641181556;11451.02666273376;8294.336453083739;8369.83260334802;8400.495970241805;8460.703875364332;8461.95769021151;6027.728752206249;6084.3915608440575;6185.474234689922;6272;6325.399087086719;10410.271281010257;10514.421706805893;10720.463976800973;10722.303050301705;10845.023947844416;10664.733381665521;10753.89246107529;10812.135029197803;10893.291936024134;10957.397343145885;6915.135608048994;7497.437692173;7613.619319034137;7822.530648161129;8067.112617611941;8726.171013753683;8761.956190219009;8798.428102173339;8894.911050889408;8908.777280568038;7373.262673732584;7531.322181003736;7543.849123017619;7609.467337286337;7633.427492937941;7335.376492998155;7340.669669864976;7364.1163060430945;7496.7750967471065;7523.548587084792;6908.274631163857;6977.79066628002;6998.825029374307;7040.964795175992;7052.435805135679;5067.2652465391575;5125.923111153261;5201.375834899685;5264.894702106013;5282.550983166474;5292.100342941786;5312.574994000548;5318.574514038945;5329.840104796862;5339.599530035341 17:25:29 INFO - PROCESS | 686 | |4;prototype.html;338.9525466434698;346.1415689091054;346.15365431519933;351.8328793822933;357.85149163097316;5481.972590137054;5673.120666296721;5688.288963879515;5712.657240565569;5714.34285057218;5599.944000560004;5603.80386686466;5612.831615051545;5633.464820842013;5651.632643878155;3880.9611903881023;4332.610065094141;4336.56634336567;4349.847755328564;4356.6732495062915;4264.677949835545;4324.7890590634515;4346.78266086696;4369.890752731191;4381.583749543788;4294.141171765644;4307.332363483665;4319.352097185416;4325.675574331922;4360.934585981213;4269.807858646368;4378.124375124972;4381;4391.341298805173;4393.7363758174615;3800.3349413852466;3802.0229480670173;3809.733318667694;3814.1227517670814;3821.6560509554274;5336.199570064483;5365.222042803811;5395.973020134914;5409.404965453797;5423.620346575742;4978.6514943953935;4979.701217926936;5003.824866129705;5022.447530771612;5039.949600504021;5546.972265138689;5876.7355469004;5883.411658834082;5909.497692696126;5961.880762384728;4210.3684447332835;4218.156368726236;4224.070704445048;4235.526867968268;4260.595243451867;6099.817005489843;6140.385961403868;6168.167297414837;6188.752449902044;6190.3190649028575;4155.8753237402925;4166.33338665812;4194.664426845906;4202.915941681149;4229.238737027303;4236.131593023423;4264.7654379009455;4279.636230920344;4291.034517233597;4294.205571969195;4828.903421931612;4904.828331008398;4933.45731969483;4948.703077815343;4949.406071271398;5816.633091223559;5891.499222566044;5897.64614123154;5919.467247947619;5938.910916336258;1483.525271912999;1504.8495150485082;1513.5005448202066;1529.05962832857;1529.678767458846;934.8878134623752;967.4823969176598;971.825071487125;972.7033254857337;984.1241295247236;4877.512248775094;5565.415631358649;5706.657600543981;5764.164196191528;5772.336181339116;6155.783917789592;6197.690115494207;6204.13142160098;6226.5641405102115;6245.437910588069;5466.863328416822;5648.5481161507805;5705.058665320259;5743.798967036134;5748.798792042342;3211.454052811028;3257.820819854883;3258.885938992124;3259.315543735842;3262.4127657021963;6129.651476675124;6282.748690052438;6289.7169627366875;6312.5581209314905;6339.144215530844;6049.517868122338;6137.833811575875;6198.783042593487;6257.0614407838275;6273.937260627426;6232.722291930143;6259.624422534663;6294.968525157345;6319.609685869102;6336.6831658416895;5893.499052580579;6038.396160383926;6088.6042407243385;6098.390160983866;6109.419605137505;6082.9695851520455;6090.69546522681;6111.8777624446375;6127.264728232462;6129.509639228761;6002.249718785152;6212.546044312561;6255.155554000152;6262.812115636538;6374.3306952771145;4274.610751505711;4302.182585308781;4337.826486940613;4355.60799528044;4356.215881141425;6069.180660610938;6097.7865774697675;6121.071862363341;6125.234345706786;6159.538034647329;5773.16289138081;5892.258415906016;5939.8120375925855;5989.910151347821;5993.520518358608;5780.942190578208;5875.529957603467;5923.378045305353;5945.316288626863;6001.609895356788;5229.450907654794;5732.598718089694;5781.82654520365;5790.957627627067;5813.447722466359;5864.266966629171;5872.647641141545;5887.293524777054;5897.9115313271195;5905.4685078343155;5776.826695199151;5784.884302313846;5794.1308803679785;5851.795187168429;5852.970735146297 17:25:29 INFO - PROCESS | 686 | |5;yui.html;658.7477830603456;664.5613894829413;673.3300366135694;753.3295367123258;767.5970115689263;12725.999999999989;13495.122817016887;13626.727465450685;13634.113782604123;13648.522301719442;12117.33354665493;12303.446344914479;12410.689732756686;12438;12443.128980971336;809.6963638635511;823.3701218567801;824.8638974569188;825.162460102996;827.1893544326564;827.3711978896052;830.2983978538126;830.8130670599097;831.8170002599419;832.4214670803793;864.5720368417642;865.0527672198932;865.1435079271539;865.4331412924513;865.4461144867258;858.7252079334615;860.9956950215271;862.5902696219308;863.6631713631689;864.2308345572445;625.809128215894;627.6234259444343;628.3779058731868;629.5467263570222;631.3118700616304;11630.244034137839;11678.416079196091;11702.473388697528;11703.765924681458;11711.648650540497;10990.701320868955;11214.215004949658;11408.54365825366;11521.769564608745;11529.769404611861;10125.89874101257;10138.290319677626;10188.94905525475;10278.53746581398;10328.845067323997;3522.101864024683;3635.2366003139373;3695.371786796251;3705.2589482103685;3773.9245215095543;43160;47566.28650570244;49806.2529062068;53953.46046539563;54369.456305436834;11065.72335691598;11125.221234513669;11208.775824483464;11267.098632109411;11359.375234362189;19123.139458724392;19129.52176195606;19149.808501915082;19150.425487235407;19177;7988.121306656263;8053.275205231557;8110.837783244302;8151.307138893142;8173.264406203351;4375.146846364928;4402.229609818333;4406.140802543473;4524.343970124313;4647.395838540968;3255.723263522627;3315.950260746091;3326.501024846244;3332.6667333266964;3333.7333013358875;644.9387308205806;655.6426747422666;657.917760279965;663.7212370804274;680.7447207297264;600.6336134957672;643.8422586466346;669.4309836638915;672.2873753820966;700.6601798127904;8887.422317549339;9001.279897608176;9020.639174433081;9092.8636070459;9181.081891810765;734.463841395784;749.1534565940452;757.9355754760907;762.3634265388351;764.3920694322787;4155.480564929384;4233.534311225762;4291.721038132511;4294.9785251073545;4299.355096735515;61527.384726152166;61768.69115654393;61837.38162618406;63157;63673.36326636767;56444;56887;57240.713796430755;57448.42551574514;58266.417335826096;43379.34930976038;44605.553944460786;48020.759896200994;48814;51683.31483536808;8491.532965686947;8606.569671516274;8761.956190219009;8874.378793484653;8907.777305567413;29904.70095299106;30879.69120308768;31371.84314078415;33427.498587521695;34587;45548.54451455443;45592.772036139606;45848.312275316566;45856.08287834292;45925.54074459212;11693.707657308296;11911.642650720492;12814.871851281368;12924.676883077998;13170.341482926007;14080.647983800487;14175.291235438393;14463.783043254149;14636.560903172922;14735.410583576537;12293.631191064282;12510.374481276081;12783.552575659807;13140.540081097115;13263;13074.934625326812;13383.866161338263;13816.240106794223;14416.495422660157;14426.134431934117;12139.817902731289;12436;12468.314242716737;12497.25016499013;13531.120477168952;11073.612423565137;11086.556537738723;11101.5559377624;11198.328100313682;11240.662780116609;10930.726731831768;11025.61410350634;11144.55421783152;11161.609343672932;11207.71980700489 17:25:29 INFO - PROCESS | 686 | __end_tp_report 17:25:29 INFO - PROCESS | 686 | __start_cc_report 17:25:29 INFO - PROCESS | 686 | _x_x_mozilla_cycle_collect,324 17:25:29 INFO - PROCESS | 686 | __end_cc_report 17:25:29 INFO - PROCESS | 686 | __startTimestamp1462926329320__endTimestamp 17:25:29 INFO - PROCESS | 686 | 17:25:29 INFO - PROCESS | 686 | ------- Summary: start ------- 17:25:29 INFO - PROCESS | 686 | Number of tests: 6 17:25:29 INFO - PROCESS | 686 | 17:25:29 INFO - PROCESS | 686 | [#0] dojo.html Cycles:165 Average:5482.16 Median:5747.83 stddev:744.72 (13.0%) stddev-sans-first:724.34 17:25:29 INFO - PROCESS | 686 | Values: 3158.0 3175.1 3191.0 3195.8 3217.7 5465.8 5478.0 5521.4 5539.7 5557.6 5418.2 5511.4 5517.8 5519.7 5592.8 4877.7 4909.5 5081.1 5096.2 5103.0 875.6 4829.9 4972.6 5024.2 5117.2 4998.0 5006.1 5010.8 5049.2 5070.0 5040.8 5043.4 5044.9 5045.1 5048.0 4805.3 4961.5 4994.3 5041.2 5064.5 5480.6 5481.1 5507.7 5524.4 5539.1 5690.1 6025.3 6031.8 6038.8 6060.4 5966.0 6028.2 6031.4 6044.5 6066.1 5663.8 5673.5 5681.7 5683.6 5687.4 5915.0 6044.0 6167.2 6186.5 6187.6 5829.7 5908.3 5917.4 5923.4 5960.0 5984.8 5989.6 5991.4 5991.6 5995.3 5747.8 5859.5 5910.1 5946.2 5963.4 5979.3 5990.3 6017.7 6029.9 6049.8 4510.5 4515.4 4520.4 4521.8 4556.5 3876.6 3925.9 3978.9 3999.0 4003.4 5483.2 5569.1 5584.3 5613.3 5653.8 5977.3 5999.6 6002.3 6006.6 6007.4 5431.6 5563.8 5597.8 5605.0 5679.1 4894.9 4908.8 4909.0 4923.3 4965.8 6084.4 6102.0 6106.2 6110.2 6110.8 5723.2 5882.1 5904.6 5906.7 5984.8 6134.9 6137.0 6137.2 6141.2 6144.4 5700.2 5825.2 5870.8 5872.6 5876.5 5864.1 5894.9 5954.4 5985.8 5995.2 5788.9 5826.8 5829.1 5829.2 5845.1 5699.3 5775.5 5800.7 5801.8 5808.4 5733.3 5754.9 5755.7 5785.8 5840.3 5756.6 5901.0 5910.2 5915.1 5933.2 5472.4 5679.6 5719.9 5794.4 5805.1 17:25:29 INFO - PROCESS | 686 | 17:25:29 INFO - PROCESS | 686 | [#1] ext.html Cycles:180 Average:58129.62 Median:39407.40 stddev:114164.36 (289.7%) stddev-sans-first:114402.91 17:25:29 INFO - PROCESS | 686 | Values: 599.9 649.6 655.2 671.6 679.8 37756.8 42655.6 42668.1 42819.8 42845.1 41590.6 42108.2 42170.0 42185.0 42193.2 8700.3 8814.7 8862.2 8867.4 8872.2 8730.7 8815.9 8873.2 8906.8 8907.0 8883.6 8905.0 8908.5 8924.8 8936.2 8875.5 8914.7 8939.2 8960.1 8967.6 8752.3 8854.0 8889.9 8899.5 8907.0 34055.0 38848.8 38922.6 39174.2 39273.4 3076.6 3125.8 3138.2 3297.2 3386.3 30400.7 30902.2 30920.5 30943.0 32052.8 3443.6 3536.8 3542.2 3550.9 3579.1 279777.0 443782.0 454407.0 456307.0 458858.0 57201.4 57593.0 57681.8 57778.7 57779.0 36566.6 37542.8 37687.2 39523.8 59688.4 17619.4 17625.9 17701.5 17703.4 17709.4 13909.2 13911.4 13922.0 13999.6 14041.8 19297.2 19313.8 19543.1 19585.8 19625.8 7355.2 7371.6 7517.0 7535.4 7665.2 1043.4 1148.7 1218.2 1220.9 1250.2 30630.2 31198.2 31381.4 31592.7 32037.0 1149.6 1225.2 1241.1 1316.7 1339.6 16680.5 16942.3 16986.5 17122.9 17128.1 478801.0 482988.0 485157.0 486740.0 486779.0 57455.4 57515.0 57610.7 57760.0 57810.4 1395.5 1412.9 1420.7 1443.3 1444.8 29849.9 30507.4 30659.7 30814.7 31200.1 49201.8 49497.0 49972.0 50006.2 50024.5 376216.0 378283.0 378553.0 380256.0 380370.0 27832.6 28301.6 28304.0 29083.1 29287.1 46253.0 46461.0 46851.3 47106.5 47252.8 40502.1 40914.8 40997.0 41326.6 41808.4 39291.0 39740.4 40571.6 40795.2 40994.0 40051.8 41269.0 42746.4 42907.6 45018.3 29604.6 32367.5 32754.8 34391.3 34696.7 25249.5 26115.9 26204.9 26285.5 26580.6 17:25:29 INFO - PROCESS | 686 | 17:25:29 INFO - PROCESS | 686 | [#2] jquery.html Cycles:180 Average:28296.34 Median:12416.96 stddev:74364.33 (598.9%) stddev-sans-first:74543.46 17:25:29 INFO - PROCESS | 686 | Values: 407.3 408.0 417.0 419.4 429.3 18042.6 18988.9 19672.4 19674.6 19894.4 12537.2 12893.1 15170.5 19573.2 19688.3 5295.5 5353.2 5449.2 5461.5 5704.1 5438.9 5593.3 5609.6 5664.5 5666.3 5849.8 5901.4 5905.3 5930.1 5938.7 5691.9 5852.4 5860.2 5862.3 5894.4 5641.1 5682.3 5733.8 5735.3 5738.0 13987.4 18501.5 22640.1 23677.4 23690.2 2193.8 2282.6 2313.5 2437.7 2456.5 10888.8 10970.0 13512.8 14166.9 14862.6 1972.4 2031.9 2078.8 2078.8 2091.1 81337.6 84510.0 84878.0 94574.5 96576.5 11109.7 11564.7 11590.8 11646.1 11786.6 16236.4 16280.5 16370.8 16372.5 16376.0 8566.0 8688.8 8756.7 8856.2 8929.4 8411.7 8415.1 8470.4 8483.8 8824.3 4935.8 4940.6 4979.7 4989.5 4997.1 2040.6 2057.7 2090.6 2101.8 2114.6 1034.1 1054.4 1082.9 1108.4 1109.7 18305.5 19310.8 19495.8 20111.0 20180.5 1028.2 1043.8 1053.1 1059.5 1062.0 9182.5 11194.6 11305.3 11313.0 11369.1 431400.0 433793.0 436987.0 464855.0 466044.0 96551.0 99869.5 102229.0 103573.5 104052.5 1047.4 1053.3 1064.6 1076.3 1079.6 17301.0 17307.8 17397.3 17591.7 17622.9 42041.0 42333.4 42758.8 42831.6 43019.6 57931.7 59029.0 60178.0 60400.0 60749.4 8777.7 9025.8 9051.0 9303.2 9514.8 9401.5 9993.6 12660.7 12929.5 13069.7 10497.7 11034.6 11088.3 11137.8 11139.0 11193.3 11279.6 11290.5 11582.8 11625.8 9587.6 11071.3 11498.3 11590.9 12187.1 9009.5 9179.2 9207.8 9252.5 9341.4 9310.6 12036.3 12109.8 12183.3 12240.3 17:25:29 INFO - PROCESS | 686 | 17:25:29 INFO - PROCESS | 686 | [#3] mootools.html Cycles:180 Average:5977.74 Median:477.72 stddev:3470.40 (726.5%) stddev-sans-first:3464.07 17:25:29 INFO - PROCESS | 686 | Values: 1534.2 1559.9 1772.3 1858.0 1885.5 7845.0 8836.4 8887.4 9427.2 9454.0 9050.8 9072.3 9094.0 9150.7 9159.5 2401.6 2440.5 2441.9 2446.8 2448.2 2348.9 2377.1 2391.4 2405.6 2409.2 2390.2 2399.9 2412.3 2463.7 2470.6 2140.6 2151.5 2154.9 2167.5 2169.2 2285.6 2327.2 2327.5 2330.8 2338.1 9124.5 9184.3 9203.0 9264.3 9266.2 5354.1 5607.6 5622.6 5627.7 5655.8 3548.3 3555.9 3589.3 3658.1 3683.4 1065.9 1082.8 1083.0 1102.6 1112.2 13095.7 13129.5 13136.9 13204.0 13206.1 4790.2 4886.8 4891.7 4929.5 4965.2 10925.6 10988.4 10999.3 11008.1 11012.1 5494.7 5507.4 5512.5 5545.2 5550.6 4485.9 4967.4 5071.2 5106.8 5117.8 4141.3 4195.7 4198.8 4228.0 4234.3 1301.7 1357.6 1379.2 1385.8 1389.6 991.4 998.9 1001.9 1006.6 1014.8 6021.8 6025.4 6038.0 6047.3 6251.0 475.2 476.2 479.3 485.5 489.1 4005.0 4040.6 4070.5 4093.7 4180.6 10780.8 11208.5 11297.7 11521.3 11589.6 11326.7 11349.6 11429.8 11439.3 11451.0 8294.3 8369.8 8400.5 8460.7 8462.0 6027.7 6084.4 6185.5 6272.0 6325.4 10410.3 10514.4 10720.5 10722.3 10845.0 10664.7 10753.9 10812.1 10893.3 10957.4 6915.1 7497.4 7613.6 7822.5 8067.1 8726.2 8762.0 8798.4 8894.9 8908.8 7373.3 7531.3 7543.8 7609.5 7633.4 7335.4 7340.7 7364.1 7496.8 7523.5 6908.3 6977.8 6998.8 7041.0 7052.4 5067.3 5125.9 5201.4 5264.9 5282.6 5292.1 5312.6 5318.6 5329.8 5339.6 17:25:29 INFO - PROCESS | 686 | 17:25:29 INFO - PROCESS | 686 | [#4] prototype.html Cycles:180 Average:4957.52 Median:5709.66 stddev:1477.64 (25.9%) stddev-sans-first:1440.54 17:25:29 INFO - PROCESS | 686 | Values: 339.0 346.1 346.2 351.8 357.9 5482.0 5673.1 5688.3 5712.7 5714.3 5599.9 5603.8 5612.8 5633.5 5651.6 3881.0 4332.6 4336.6 4349.8 4356.7 4264.7 4324.8 4346.8 4369.9 4381.6 4294.1 4307.3 4319.4 4325.7 4360.9 4269.8 4378.1 4381.0 4391.3 4393.7 3800.3 3802.0 3809.7 3814.1 3821.7 5336.2 5365.2 5396.0 5409.4 5423.6 4978.7 4979.7 5003.8 5022.4 5039.9 5547.0 5876.7 5883.4 5909.5 5961.9 4210.4 4218.2 4224.1 4235.5 4260.6 6099.8 6140.4 6168.2 6188.8 6190.3 4155.9 4166.3 4194.7 4202.9 4229.2 4236.1 4264.8 4279.6 4291.0 4294.2 4828.9 4904.8 4933.5 4948.7 4949.4 5816.6 5891.5 5897.6 5919.5 5938.9 1483.5 1504.8 1513.5 1529.1 1529.7 934.9 967.5 971.8 972.7 984.1 4877.5 5565.4 5706.7 5764.2 5772.3 6155.8 6197.7 6204.1 6226.6 6245.4 5466.9 5648.5 5705.1 5743.8 5748.8 3211.5 3257.8 3258.9 3259.3 3262.4 6129.7 6282.7 6289.7 6312.6 6339.1 6049.5 6137.8 6198.8 6257.1 6273.9 6232.7 6259.6 6295.0 6319.6 6336.7 5893.5 6038.4 6088.6 6098.4 6109.4 6083.0 6090.7 6111.9 6127.3 6129.5 6002.2 6212.5 6255.2 6262.8 6374.3 4274.6 4302.2 4337.8 4355.6 4356.2 6069.2 6097.8 6121.1 6125.2 6159.5 5773.2 5892.3 5939.8 5989.9 5993.5 5780.9 5875.5 5923.4 5945.3 6001.6 5229.5 5732.6 5781.8 5791.0 5813.4 5864.3 5872.6 5887.3 5897.9 5905.5 5776.8 5784.9 5794.1 5851.8 5853.0 17:25:29 INFO - PROCESS | 686 | 17:25:29 INFO - PROCESS | 686 | [#5] yui.html Cycles:180 Average:14461.15 Median:43269.67 stddev:16812.46 (38.9%) stddev-sans-first:16827.67 17:25:29 INFO - PROCESS | 686 | Values: 658.7 664.6 673.3 753.3 767.6 12726.0 13495.1 13626.7 13634.1 13648.5 12117.3 12303.4 12410.7 12438.0 12443.1 809.7 823.4 824.9 825.2 827.2 827.4 830.3 830.8 831.8 832.4 864.6 865.1 865.1 865.4 865.4 858.7 861.0 862.6 863.7 864.2 625.8 627.6 628.4 629.5 631.3 11630.2 11678.4 11702.5 11703.8 11711.6 10990.7 11214.2 11408.5 11521.8 11529.8 10125.9 10138.3 10188.9 10278.5 10328.8 3522.1 3635.2 3695.4 3705.3 3773.9 43160.0 47566.3 49806.3 53953.5 54369.5 11065.7 11125.2 11208.8 11267.1 11359.4 19123.1 19129.5 19149.8 19150.4 19177.0 7988.1 8053.3 8110.8 8151.3 8173.3 4375.1 4402.2 4406.1 4524.3 4647.4 3255.7 3316.0 3326.5 3332.7 3333.7 644.9 655.6 657.9 663.7 680.7 600.6 643.8 669.4 672.3 700.7 8887.4 9001.3 9020.6 9092.9 9181.1 734.5 749.2 757.9 762.4 764.4 4155.5 4233.5 4291.7 4295.0 4299.4 61527.4 61768.7 61837.4 63157.0 63673.4 56444.0 56887.0 57240.7 57448.4 58266.4 43379.3 44605.6 48020.8 48814.0 51683.3 8491.5 8606.6 8762.0 8874.4 8907.8 29904.7 30879.7 31371.8 33427.5 34587.0 45548.5 45592.8 45848.3 45856.1 45925.5 11693.7 11911.6 12814.9 12924.7 13170.3 14080.6 14175.3 14463.8 14636.6 14735.4 12293.6 12510.4 12783.6 13140.5 13263.0 13074.9 13383.9 13816.2 14416.5 14426.1 12139.8 12436.0 12468.3 12497.3 13531.1 11073.6 11086.6 11101.6 11198.3 11240.7 10930.7 11025.6 11144.6 11161.6 11207.7 17:25:29 INFO - PROCESS | 686 | -------- Summary: end -------- 17:25:29 INFO - PROCESS | 686 | 17:25:30 INFO - TEST-INFO | 686: exit 0 17:25:30 INFO - TEST-OK | dromaeo_css | took 1111036ms 17:25:30 INFO - TEST-START | kraken 17:25:30 INFO - operating with platform_type : linux_ 17:25:30 INFO - Initialising browser for kraken test... 17:25:30 INFO - TEST-INFO | started process 932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8AlD_i/profile http://localhost:38137/getInfo.html) 17:25:33 INFO - PROCESS | 932 | 17:25:33 INFO - PROCESS | 932 | (process:1000): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:25:34 INFO - PROCESS | 932 | __metrics Screen width/height:1600/1200 17:25:34 INFO - PROCESS | 932 | colorDepth:24 17:25:34 INFO - PROCESS | 932 | Browser inner width/height: 1024/697 17:25:34 INFO - PROCESS | 932 | __metrics 17:25:35 ERROR - PROCESS | 932 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:25:36 INFO - TEST-INFO | 932: exit 0 17:25:36 INFO - Browser initialized. 17:25:36 INFO - Running cycle 1/1 for kraken test... 17:25:36 INFO - TEST-INFO | started process 1056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8AlD_i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:38 INFO - PROCESS | 1056 | 17:25:38 INFO - PROCESS | 1056 | (process:1123): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:25:48 INFO - PROCESS | 1056 | RSS: Main: 163647488 17:25:48 INFO - PROCESS | 1056 | 17:25:50 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38137/tests/kraken/driver.html?testName=audio-beat-detection) 17:25:51 INFO - PROCESS | 1056 | RSS: Main: 167698432 17:25:51 INFO - PROCESS | 1056 | 17:25:54 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38137/tests/kraken/driver.html?testName=audio-dft) 17:25:54 INFO - PROCESS | 1056 | RSS: Main: 167837696 17:25:54 INFO - PROCESS | 1056 | 17:25:57 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38137/tests/kraken/driver.html?testName=audio-fft) 17:25:58 INFO - PROCESS | 1056 | RSS: Main: 162893824 17:25:58 INFO - PROCESS | 1056 | 17:26:00 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38137/tests/kraken/driver.html?testName=audio-oscillator) 17:26:01 INFO - PROCESS | 1056 | RSS: Main: 163631104 17:26:01 INFO - PROCESS | 1056 | 17:26:03 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:04 INFO - PROCESS | 1056 | RSS: Main: 163508224 17:26:04 INFO - PROCESS | 1056 | 17:26:07 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38137/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:07 INFO - PROCESS | 1056 | RSS: Main: 163799040 17:26:07 INFO - PROCESS | 1056 | 17:26:11 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38137/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:12 INFO - PROCESS | 1056 | RSS: Main: 162050048 17:26:12 INFO - PROCESS | 1056 | 17:26:15 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38137/tests/kraken/driver.html?testName=json-parse-financial) 17:26:15 INFO - PROCESS | 1056 | RSS: Main: 162721792 17:26:15 INFO - PROCESS | 1056 | 17:26:17 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:17 INFO - PROCESS | 1056 | RSS: Main: 163266560 17:26:17 INFO - PROCESS | 1056 | 17:26:19 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38137/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:20 INFO - PROCESS | 1056 | RSS: Main: 163528704 17:26:20 INFO - PROCESS | 1056 | 17:26:22 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:23 INFO - PROCESS | 1056 | RSS: Main: 163581952 17:26:23 INFO - PROCESS | 1056 | 17:26:25 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:26 INFO - PROCESS | 1056 | RSS: Main: 163971072 17:26:26 INFO - PROCESS | 1056 | 17:26:29 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:29 INFO - PROCESS | 1056 | RSS: Main: 163803136 17:26:29 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | Cycle 1(1): loaded http://localhost:38137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38137/tests/kraken/driver.html?testName=ai-astar) 17:26:31 INFO - PROCESS | 1056 | RSS: Main: 165228544 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | __start_tp_report 17:26:31 INFO - PROCESS | 1056 | _x_x_mozilla_page_load 17:26:31 INFO - PROCESS | 1056 | _x_x_mozilla_page_load_details 17:26:31 INFO - PROCESS | 1056 | |i|pagename|runs| 17:26:31 INFO - PROCESS | 1056 | |0;ai-astar;112;116;105;113;111;112;106;110;116;113 17:26:31 INFO - PROCESS | 1056 | |1;audio-beat-detection;157;126;151;208;130;156;148;129;176;125 17:26:31 INFO - PROCESS | 1056 | |2;audio-dft;161;161;162;163;167;165;167;163;161;162 17:26:31 INFO - PROCESS | 1056 | |3;audio-fft;75;75;75;155;77;77;76;77;166;77 17:26:31 INFO - PROCESS | 1056 | |4;audio-oscillator;93;96;184;91;93;93;156;92;92;160 17:26:31 INFO - PROCESS | 1056 | |5;imaging-gaussian-blur;117;117;118;117;117;117;119;118;119;119 17:26:31 INFO - PROCESS | 1056 | |6;imaging-darkroom;146;146;147;146;147;146;146;146;146;147 17:26:31 INFO - PROCESS | 1056 | |7;imaging-desaturate;98;96;99;98;99;100;99;97;100;100 17:26:31 INFO - PROCESS | 1056 | |8;json-parse-financial;58;60;60;59;64;59;58;117;57;57 17:26:31 INFO - PROCESS | 1056 | |9;json-stringify-tinderbox;60;59;60;59;60;59;59;59;59;59 17:26:31 INFO - PROCESS | 1056 | |10;stanford-crypto-aes;78;78;80;80;80;83;79;79;87;79 17:26:31 INFO - PROCESS | 1056 | |11;stanford-crypto-ccm;131;128;132;123;124;125;125;127;192;126 17:26:31 INFO - PROCESS | 1056 | |12;stanford-crypto-pbkdf2;175;172;169;171;169;169;166;168;170;174 17:26:31 INFO - PROCESS | 1056 | |13;stanford-crypto-sha256-iterative;67;69;67;66;73;66;67;66;64;64 17:26:31 INFO - PROCESS | 1056 | __end_tp_report 17:26:31 INFO - PROCESS | 1056 | __start_cc_report 17:26:31 INFO - PROCESS | 1056 | _x_x_mozilla_cycle_collect,840 17:26:31 INFO - PROCESS | 1056 | __end_cc_report 17:26:31 INFO - PROCESS | 1056 | __startTimestamp1462926391963__endTimestamp 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | ------- Summary: start ------- 17:26:31 INFO - PROCESS | 1056 | Number of tests: 14 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.66 (3.3%) stddev-sans-first:3.87 17:26:31 INFO - PROCESS | 1056 | Values: 112.0 116.0 105.0 113.0 111.0 112.0 106.0 110.0 116.0 113.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:153.50 stddev:26.18 (17.1%) stddev-sans-first:27.67 17:26:31 INFO - PROCESS | 1056 | Values: 157.0 126.0 151.0 208.0 130.0 156.0 148.0 129.0 176.0 125.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.35 (1.4%) stddev-sans-first:2.35 17:26:31 INFO - PROCESS | 1056 | Values: 161.0 161.0 162.0 163.0 167.0 165.0 167.0 163.0 161.0 162.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.50 stddev:35.68 (46.6%) stddev-sans-first:37.25 17:26:31 INFO - PROCESS | 1056 | Values: 75.0 75.0 75.0 155.0 77.0 77.0 76.0 77.0 166.0 77.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#4] audio-oscillator Cycles:10 Average:115.00 Median:92.50 stddev:36.38 (39.3%) stddev-sans-first:37.71 17:26:31 INFO - PROCESS | 1056 | Values: 93.0 96.0 184.0 91.0 93.0 93.0 156.0 92.0 92.0 160.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 17:26:31 INFO - PROCESS | 1056 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 119.0 118.0 119.0 119.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:26:31 INFO - PROCESS | 1056 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#7] imaging-desaturate Cycles:10 Average:98.60 Median:98.00 stddev:1.35 (1.4%) stddev-sans-first:1.41 17:26:31 INFO - PROCESS | 1056 | Values: 98.0 96.0 99.0 98.0 99.0 100.0 99.0 97.0 100.0 100.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:59.00 stddev:18.42 (31.2%) stddev-sans-first:19.36 17:26:31 INFO - PROCESS | 1056 | Values: 58.0 60.0 60.0 59.0 64.0 59.0 58.0 117.0 57.0 57.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 17:26:31 INFO - PROCESS | 1056 | Values: 60.0 59.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:2.75 (3.4%) stddev-sans-first:2.79 17:26:31 INFO - PROCESS | 1056 | Values: 78.0 78.0 80.0 80.0 80.0 83.0 79.0 79.0 87.0 79.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:127.50 stddev:20.83 (16.3%) stddev-sans-first:22.07 17:26:31 INFO - PROCESS | 1056 | Values: 131.0 128.0 132.0 123.0 124.0 125.0 125.0 127.0 192.0 126.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.50 stddev:2.75 (1.6%) stddev-sans-first:2.33 17:26:31 INFO - PROCESS | 1056 | Values: 175.0 172.0 169.0 171.0 169.0 169.0 166.0 168.0 170.0 174.0 17:26:31 INFO - PROCESS | 1056 | 17:26:31 INFO - PROCESS | 1056 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:2.60 (3.9%) stddev-sans-first:2.76 17:26:31 INFO - PROCESS | 1056 | Values: 67.0 69.0 67.0 66.0 73.0 66.0 67.0 66.0 64.0 64.0 17:26:31 INFO - PROCESS | 1056 | -------- Summary: end -------- 17:26:31 INFO - PROCESS | 1056 | 17:26:32 INFO - TEST-INFO | 1056: exit 0 17:26:32 INFO - TEST-OK | kraken | took 62885ms 17:26:32 INFO - SUITE-END | took 1173s 17:26:33 INFO - Completed test suite (00:19:34) 17:26:33 INFO - javascript benchmark 17:26:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3157.95263071054, 3175.0950978971, 3190.9680903190974, 3195.7762956593047, 3217.7104060634547, 5465.781368745251, 5478.0413427650155, 5521.365043020054, 5539.723013849311, 5557.6109672322855, 5418.187271909215, 5511.366192887819, 5517.779288828442, 5519.69641669708, 5592.804251851186, 4877.658563900528, 4909.484504127069, 5081.136206844827, 5096.235564665293, 5102.953894451629, 875.5770209924932, 4829.90340193196, 4972.627052971024, 5024.196128619422, 5117.1556693145585, 4998.0, 5006.123928312549, 5010.799568017275, 5049.166887463564, 5070.0, 5040.84877453677, 5043.36957880265, 5044.9495505045215, 5045.142325804622, 5047.974760126176, 4805.327254184417, 4961.5038496150455, 4994.300797888299, 5041.19340905457, 5064.468230835783, 5480.588955828289, 5481.068218402841, 5507.669539827623, 5524.419935906712, 5539.113741801292, 5690.06113991191, 6025.276966763972, 6031.758729650809, 6038.758449662008, 6060.424259695322, 5966.0, 6028.216331876828, 6031.366706495799, 6044.486218671418, 6066.090086487018, 5663.801766938137, 5673.489385955242, 5681.687507187103, 5683.573731970118, 5687.374388817227, 5915.0, 6043.969780151159, 6167.198264225622, 6186.4741496972365, 6187.628742275478, 5829.650220986754, 5908.291005079418, 5917.408259174048, 5923.378045305267, 5959.970200148971, 5984.820455386345, 5989.580729348903, 5991.370906054889, 5991.64050156992, 5995.340512543617, 5747.827565173052, 5859.501942334864, 5910.083936989773, 5946.197263369476, 5963.4334738199805, 5979.252593425822, 5990.31111422192, 6017.669028203491, 6029.909551356734, 6049.78825741097, 4510.481294651091, 4515.367848501212, 4520.389747384061, 4521.84173553924, 4556.498785133633, 3876.6317199865966, 3925.862594809225, 3978.8806335809973, 3998.9800051000143, 4003.3594624859884, 5483.2049352844415, 5569.10894256917, 5584.329880414376, 5613.270274864323, 5653.773849046074, 5977.312609049928, 5999.640021598718, 6002.309734380515, 6006.579539432285, 6007.429294217042, 5431.592630552725, 5563.805266815642, 5597.832065038056, 5605.047141985872, 5679.062954612526, 4894.926576101361, 4908.754562271872, 4909.018196360671, 4923.335349727812, 4965.776540055706, 6084.421979911901, 6102.0, 6106.206193194945, 6110.175126357974, 6110.847228819226, 5723.227364305765, 5882.058870580858, 5904.61619994699, 5906.7341969612335, 5984.760609575743, 6134.907976380268, 6137.0, 6137.232845894263, 6141.232345956755, 6144.38556144382, 5700.230468886647, 5825.155352473783, 5870.823875283749, 5872.588918775645, 5876.500497457764, 5864.149698293638, 5894.852628684317, 5954.4343287389365, 5985.760569577168, 5995.1906492624685, 5788.855278618068, 5826.76692932278, 5829.067349224104, 5829.15477255804, 5845.09401042839, 5699.344575373885, 5775.537956963517, 5800.6809625471005, 5801.796937107181, 5808.419158084158, 5733.31200255972, 5754.9424505754405, 5755.740991655469, 5785.82642520725, 5840.269966254218, 5756.568257380797, 5900.970495147497, 5910.231669882888, 5915.142304365929, 5933.169356290036, 5472.370677372153, 5679.6024278301775, 5719.942800572107, 5794.449527294901, 5805.10020946754], "value": 5431.558799110839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8620317327014, 649.5907578225717, 655.2137435077907, 671.5534169777098, 679.7790718016646, 37756.81121594392, 42655.57344426559, 42668.14663706724, 42819.78590107045, 42845.14309713804, 41590.58409415912, 42108.15783684332, 42170.0, 42185.0, 42193.156136877245, 8700.347473939464, 8814.691485798, 8862.246709029709, 8867.423617464845, 8872.20150186483, 8730.694425695103, 8815.911840881574, 8873.20141187293, 8906.777330566756, 8907.0, 8883.644654213856, 8905.020447750774, 8908.465492070496, 8924.776880577972, 8936.195742383185, 8875.467471951704, 8914.687985920495, 8939.195472407482, 8960.059193784657, 8967.596458159333, 8752.299816014767, 8854.0, 8889.911100888972, 8899.510526921016, 8907.0, 34055.0, 38848.80575597132, 38922.61077389218, 39174.21651566981, 39273.41089883654, 3076.646185688652, 3125.828079455629, 3138.168385377877, 3297.159224397787, 3386.2888793353177, 30400.695993040008, 30902.22744431407, 30920.536191957137, 30943.0, 32052.839735801404, 3443.6212016678146, 3536.8054756988354, 3542.1852973815908, 3550.946735798965, 3579.069441945113, 279777.0, 443782.0, 454407.0, 456307.0, 458857.9999999967, 57201.427985720446, 57593.0, 57681.846363073346, 57778.7111064442, 57779.0, 36566.63433365685, 37542.812285938395, 37687.246255074744, 39523.80238098791, 59688.40311596915, 17619.383321583682, 17625.884893812825, 17701.46895593134, 17703.38038168684, 17709.38017169393, 13909.165450073027, 13911.373988170557, 13922.0, 13999.580012599637, 14041.78937315941, 19297.228110875687, 19313.78527797487, 19543.120559574854, 19585.804141958684, 19625.803741962398, 7355.154157271875, 7371.631418429057, 7517.0, 7535.397168226528, 7665.23347665229, 1043.3583346242158, 1148.7128217945515, 1218.1959906461693, 1220.926744395339, 1250.2436026204198, 30630.234244144074, 31198.22004449907, 31381.37237255242, 31592.684073159435, 32037.0, 1149.5918948773065, 1225.2342286071205, 1241.1312081542956, 1316.7498175346655, 1339.6316013096477, 16680.49958501247, 16942.322307107577, 16986.490405287863, 17122.91438542824, 17128.143592820557, 478801.0, 482988.0, 485157.0, 486740.0, 486779.0, 57455.425445745845, 57515.0, 57610.71194644084, 57760.0, 57810.42189578134, 1395.483671041721, 1412.9293535323193, 1420.666143456287, 1443.336065409923, 1444.8049513315777, 29849.850750746107, 30507.389852203276, 30659.693403065685, 30814.69185308118, 31200.063998080095, 49201.753991229816, 49497.0, 49972.0, 50006.249906250705, 50024.49975500198, 376216.0, 378283.0, 378553.0, 380256.0, 380370.0, 27832.582511261942, 28301.57547636746, 28304.0, 29083.12750617485, 29287.12138635844, 46253.0, 46461.0, 46851.297230540884, 47106.528934710215, 47252.7637361811, 40502.114640511776, 40914.795426022676, 40997.0, 41326.586734132274, 41808.37287440752, 39291.0, 39740.40389394104, 40571.59428405796, 40795.1840963185, 40994.0, 40051.79974100111, 41269.0, 42746.35880461733, 42907.570924291605, 45018.32472512849, 29604.555931660612, 32367.51448728318, 32754.83622581872, 34391.31217375689, 34696.65303347035, 25249.49501010006, 26115.869420652776, 26204.86897565576, 26285.474290514467, 26580.601290981038], "value": 19761.166916359205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.34417587683845, 408.0349972315471, 416.9916601667967, 419.44214195120486, 429.2595273153808, 18042.639147217065, 18988.905055474737, 19672.409827705174, 19674.606507869852, 19894.40316790495, 12537.185082969601, 12893.097483176158, 15170.469033583826, 19573.217071317165, 19688.310909118183, 5295.4969277918535, 5353.223782551528, 5449.1826226066205, 5461.508464238218, 5704.1443783432405, 5438.8912221755545, 5593.300837395325, 5609.607327487078, 5664.518515926131, 5666.320041595014, 5849.824505264849, 5901.439363260483, 5905.261842269716, 5930.051191809312, 5938.732757025944, 5691.9146212806845, 5852.385499522553, 5860.238169038041, 5862.296524417097, 5894.351621321651, 5641.12562552805, 5682.346530149044, 5733.827985160452, 5735.311762588516, 5737.967165910134, 13987.37056832445, 18501.537461563435, 22640.094396224133, 23677.408064798346, 23690.170844020377, 2193.824494040473, 2282.566312400655, 2313.4910319729634, 2437.744036876138, 2456.4841383309526, 10888.836667449994, 10969.957854003856, 13512.797308040388, 14166.929165354108, 14862.554123376316, 1972.3984184823623, 2031.8882461464614, 2078.8306080977027, 2078.844086693489, 2091.0799248330836, 81337.59331203366, 84510.0, 84878.0, 94574.5271273646, 96576.51711741467, 11109.666709998713, 11564.653060408033, 11590.826137607773, 11646.068314534818, 11786.5874694387, 16236.431724889571, 16280.511584652479, 16370.754438683429, 16372.508824735278, 16376.0, 8565.957170214233, 8688.78278043054, 8756.693515726918, 8856.24721898633, 8929.374943754005, 8411.663533458594, 8415.074341822394, 8470.449420787629, 8483.83032339362, 8824.338174636929, 4935.802567897315, 4940.629452790983, 4979.726115063634, 4989.480312442193, 4997.075541024922, 2040.5612793249522, 2057.711920331155, 2090.5818836232816, 2101.779313172095, 2114.587655407181, 1034.1364960258118, 1054.3673795722505, 1082.9025387715144, 1108.3626914524182, 1109.7170221593603, 18305.542361440803, 19310.80689193118, 19495.8050419494, 20111.0, 20180.495487612927, 1028.2391030637275, 1043.796459690353, 1053.1259054984343, 1059.502034043998, 1061.9734506637396, 9182.494962777111, 11194.552217911192, 11305.321680699184, 11313.0, 11369.147313951487, 431400.0, 433793.0, 436987.0, 464855.0, 466044.0, 96551.0, 99869.50065249627, 102229.0, 103573.48213258885, 104052.47973760082, 1047.4448542272607, 1053.3258714422775, 1064.595453727594, 1076.321917192164, 1079.6491140379408, 17301.0, 17307.826921730622, 17397.30410783605, 17591.736123958406, 17622.91188544049, 42041.0, 42333.36499952565, 42758.78620606877, 42831.57168428276, 43019.56980430156, 57931.71034144971, 59029.0, 60178.0, 60400.0, 60749.39250607437, 8777.692780752643, 9025.819483610423, 9051.0, 9303.209227215491, 9514.762130946781, 9401.529923503935, 9993.600255989679, 12660.746785064432, 12929.54746583865, 13069.738605228033, 10497.685069447929, 11034.613788517363, 11088.279261847954, 11137.832932505857, 11139.0, 11193.27243729155, 11279.605213817476, 11290.548378064785, 11582.768344633228, 11625.76748465009, 9587.561865720198, 11071.280366776135, 11498.310101393943, 11590.88409115898, 12187.146899717289, 9009.504477253551, 9179.219766319937, 9207.802985611828, 9252.53737313145, 9341.392809467363, 9310.581023853807, 12036.338001410006, 12109.75780484403, 12183.329916854658, 12240.326782027074], "value": 9383.878277569653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.2252162657855, 1559.8518140776625, 1772.3265159239488, 1857.9721304180432, 1885.4532185666158, 7845.0, 8836.425632333894, 8887.377883548153, 9427.245820334383, 9453.96006439292, 9050.773730656736, 9072.274218062556, 9094.045125261851, 9150.679726209568, 9159.45043297401, 2401.6157414813633, 2440.4996975619956, 2441.9023239070507, 2446.7675570820834, 2448.24104527597, 2348.9177878774244, 2377.072941552796, 2391.366287933699, 2405.6271277951946, 2409.1567951217107, 2390.2231774673214, 2399.940001499959, 2412.2522018174336, 2463.692038495188, 2470.6170543565777, 2140.5504843982703, 2151.451379898124, 2154.9353519394444, 2167.5231449081175, 2169.1865550418593, 2285.5885940530698, 2327.2320134355623, 2327.4995875886766, 2330.753047119783, 2338.076459798387, 9124.543772811332, 9184.26525877935, 9202.953985230031, 9264.25885929124, 9266.212371948392, 5354.063038968165, 5607.635503692247, 5622.550195984311, 5627.662340259557, 5655.773769049233, 3548.290341931598, 3555.8933232003083, 3589.335972845032, 3658.067192865829, 3683.4106542953, 1065.8880817514128, 1082.783443311341, 1082.978340433187, 1102.597551893561, 1112.1603189591888, 13095.672608184776, 13129.540466083641, 13136.868631313755, 13204.0, 13206.075574709774, 4790.233562630032, 4886.804527818847, 4891.706497610155, 4929.482404347564, 4965.205567109245, 10925.617603383844, 10988.395638239814, 10999.34003959765, 11008.119350451945, 11012.063974562092, 5494.697791621419, 5507.366652834975, 5512.503874651301, 5545.195946587723, 5550.639208451518, 4485.932711009337, 4967.379077615298, 5071.163258062452, 5106.821261255913, 5117.769700363493, 4141.316682747313, 4195.664346852244, 4198.8110535026, 4227.957720422818, 4234.343676730112, 1301.7136230029378, 1357.5723647051148, 1379.1793882639813, 1385.819843420349, 1389.6178550898583, 991.4002028772633, 998.9051040151174, 1001.929864909464, 1006.5571148694551, 1014.8122597319372, 6021.849453763691, 6025.367336429699, 6037.969810151009, 6047.3045599755715, 6251.031090181029, 475.23724422301706, 476.17621514779626, 479.25715141530486, 485.4975100770685, 489.0561216851511, 4004.9599504004586, 4040.6363427291685, 4070.531888832763, 4093.713440059167, 4180.602842729936, 10780.78438431227, 11208.495617697223, 11297.71755706114, 11521.251118677259, 11589.594364197214, 11326.660200194008, 11349.602763903224, 11429.828552571718, 11439.313641181556, 11451.02666273376, 8294.336453083739, 8369.83260334802, 8400.495970241805, 8460.703875364332, 8461.95769021151, 6027.728752206249, 6084.3915608440575, 6185.474234689922, 6272.0, 6325.399087086719, 10410.271281010257, 10514.421706805893, 10720.463976800973, 10722.303050301705, 10845.023947844416, 10664.733381665521, 10753.89246107529, 10812.135029197803, 10893.291936024134, 10957.397343145885, 6915.135608048994, 7497.437692173, 7613.619319034137, 7822.530648161129, 8067.112617611941, 8726.171013753683, 8761.956190219009, 8798.428102173339, 8894.911050889408, 8908.777280568038, 7373.262673732584, 7531.322181003736, 7543.849123017619, 7609.467337286337, 7633.427492937941, 7335.376492998155, 7340.669669864976, 7364.1163060430945, 7496.7750967471065, 7523.548587084792, 6908.274631163857, 6977.79066628002, 6998.825029374307, 7040.964795175992, 7052.435805135679, 5067.2652465391575, 5125.923111153261, 5201.375834899685, 5264.894702106013, 5282.550983166474, 5292.100342941786, 5312.574994000548, 5318.574514038945, 5329.840104796862, 5339.599530035341], "value": 4690.626924937654, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.9525466434698, 346.1415689091054, 346.15365431519933, 351.8328793822933, 357.85149163097316, 5481.972590137054, 5673.120666296721, 5688.288963879515, 5712.657240565569, 5714.34285057218, 5599.944000560004, 5603.80386686466, 5612.831615051545, 5633.464820842013, 5651.632643878155, 3880.9611903881023, 4332.610065094141, 4336.56634336567, 4349.847755328564, 4356.6732495062915, 4264.677949835545, 4324.7890590634515, 4346.78266086696, 4369.890752731191, 4381.583749543788, 4294.141171765644, 4307.332363483665, 4319.352097185416, 4325.675574331922, 4360.934585981213, 4269.807858646368, 4378.124375124972, 4381.0, 4391.341298805173, 4393.7363758174615, 3800.3349413852466, 3802.0229480670173, 3809.733318667694, 3814.1227517670814, 3821.6560509554274, 5336.199570064483, 5365.222042803811, 5395.973020134914, 5409.404965453797, 5423.620346575742, 4978.6514943953935, 4979.701217926936, 5003.824866129705, 5022.447530771612, 5039.949600504021, 5546.972265138689, 5876.7355469004, 5883.411658834082, 5909.497692696126, 5961.880762384728, 4210.3684447332835, 4218.156368726236, 4224.070704445048, 4235.526867968268, 4260.595243451867, 6099.817005489843, 6140.385961403868, 6168.167297414837, 6188.752449902044, 6190.3190649028575, 4155.8753237402925, 4166.33338665812, 4194.664426845906, 4202.915941681149, 4229.238737027303, 4236.131593023423, 4264.7654379009455, 4279.636230920344, 4291.034517233597, 4294.205571969195, 4828.903421931612, 4904.828331008398, 4933.45731969483, 4948.703077815343, 4949.406071271398, 5816.633091223559, 5891.499222566044, 5897.64614123154, 5919.467247947619, 5938.910916336258, 1483.525271912999, 1504.8495150485082, 1513.5005448202066, 1529.05962832857, 1529.678767458846, 934.8878134623752, 967.4823969176598, 971.825071487125, 972.7033254857337, 984.1241295247236, 4877.512248775094, 5565.415631358649, 5706.657600543981, 5764.164196191528, 5772.336181339116, 6155.783917789592, 6197.690115494207, 6204.13142160098, 6226.5641405102115, 6245.437910588069, 5466.863328416822, 5648.5481161507805, 5705.058665320259, 5743.798967036134, 5748.798792042342, 3211.454052811028, 3257.820819854883, 3258.885938992124, 3259.315543735842, 3262.4127657021963, 6129.651476675124, 6282.748690052438, 6289.7169627366875, 6312.5581209314905, 6339.144215530844, 6049.517868122338, 6137.833811575875, 6198.783042593487, 6257.0614407838275, 6273.937260627426, 6232.722291930143, 6259.624422534663, 6294.968525157345, 6319.609685869102, 6336.6831658416895, 5893.499052580579, 6038.396160383926, 6088.6042407243385, 6098.390160983866, 6109.419605137505, 6082.9695851520455, 6090.69546522681, 6111.8777624446375, 6127.264728232462, 6129.509639228761, 6002.249718785152, 6212.546044312561, 6255.155554000152, 6262.812115636538, 6374.3306952771145, 4274.610751505711, 4302.182585308781, 4337.826486940613, 4355.60799528044, 4356.215881141425, 6069.180660610938, 6097.7865774697675, 6121.071862363341, 6125.234345706786, 6159.538034647329, 5773.16289138081, 5892.258415906016, 5939.8120375925855, 5989.910151347821, 5993.520518358608, 5780.942190578208, 5875.529957603467, 5923.378045305353, 5945.316288626863, 6001.609895356788, 5229.450907654794, 5732.598718089694, 5781.82654520365, 5790.957627627067, 5813.447722466359, 5864.266966629171, 5872.647641141545, 5887.293524777054, 5897.9115313271195, 5905.4685078343155, 5776.826695199151, 5784.884302313846, 5794.1308803679785, 5851.795187168429, 5852.970735146297], "value": 4484.537940104308, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.7477830603456, 664.5613894829413, 673.3300366135694, 753.3295367123258, 767.5970115689263, 12725.999999999989, 13495.122817016887, 13626.727465450685, 13634.113782604123, 13648.522301719442, 12117.33354665493, 12303.446344914479, 12410.689732756686, 12438.0, 12443.128980971336, 809.6963638635511, 823.3701218567801, 824.8638974569188, 825.162460102996, 827.1893544326564, 827.3711978896052, 830.2983978538126, 830.8130670599097, 831.8170002599419, 832.4214670803793, 864.5720368417642, 865.0527672198932, 865.1435079271539, 865.4331412924513, 865.4461144867258, 858.7252079334615, 860.9956950215271, 862.5902696219308, 863.6631713631689, 864.2308345572445, 625.809128215894, 627.6234259444343, 628.3779058731868, 629.5467263570222, 631.3118700616304, 11630.244034137839, 11678.416079196091, 11702.473388697528, 11703.765924681458, 11711.648650540497, 10990.701320868955, 11214.215004949658, 11408.54365825366, 11521.769564608745, 11529.769404611861, 10125.89874101257, 10138.290319677626, 10188.94905525475, 10278.53746581398, 10328.845067323997, 3522.101864024683, 3635.2366003139373, 3695.371786796251, 3705.2589482103685, 3773.9245215095543, 43160.0, 47566.28650570244, 49806.2529062068, 53953.46046539563, 54369.456305436834, 11065.72335691598, 11125.221234513669, 11208.775824483464, 11267.098632109411, 11359.375234362189, 19123.139458724392, 19129.52176195606, 19149.808501915082, 19150.425487235407, 19177.0, 7988.121306656263, 8053.275205231557, 8110.837783244302, 8151.307138893142, 8173.264406203351, 4375.146846364928, 4402.229609818333, 4406.140802543473, 4524.343970124313, 4647.395838540968, 3255.723263522627, 3315.950260746091, 3326.501024846244, 3332.6667333266964, 3333.7333013358875, 644.9387308205806, 655.6426747422666, 657.917760279965, 663.7212370804274, 680.7447207297264, 600.6336134957672, 643.8422586466346, 669.4309836638915, 672.2873753820966, 700.6601798127904, 8887.422317549339, 9001.279897608176, 9020.639174433081, 9092.8636070459, 9181.081891810765, 734.463841395784, 749.1534565940452, 757.9355754760907, 762.3634265388351, 764.3920694322787, 4155.480564929384, 4233.534311225762, 4291.721038132511, 4294.9785251073545, 4299.355096735515, 61527.384726152166, 61768.69115654393, 61837.38162618406, 63157.0, 63673.36326636767, 56444.0, 56887.0, 57240.713796430755, 57448.42551574514, 58266.417335826096, 43379.34930976038, 44605.553944460786, 48020.759896200994, 48814.0, 51683.31483536808, 8491.532965686947, 8606.569671516274, 8761.956190219009, 8874.378793484653, 8907.777305567413, 29904.70095299106, 30879.69120308768, 31371.84314078415, 33427.498587521695, 34587.0, 45548.54451455443, 45592.772036139606, 45848.312275316566, 45856.08287834292, 45925.54074459212, 11693.707657308296, 11911.642650720492, 12814.871851281368, 12924.676883077998, 13170.341482926007, 14080.647983800487, 14175.291235438393, 14463.783043254149, 14636.560903172922, 14735.410583576537, 12293.631191064282, 12510.374481276081, 12783.552575659807, 13140.540081097115, 13263.0, 13074.934625326812, 13383.866161338263, 13816.240106794223, 14416.495422660157, 14426.134431934117, 12139.817902731289, 12436.0, 12468.314242716737, 12497.25016499013, 13531.120477168952, 11073.612423565137, 11086.556537738723, 11101.5559377624, 11198.328100313682, 11240.662780116609, 10930.726731831768, 11025.61410350634, 11144.55421783152, 11161.609343672932, 11207.71980700489], "value": 6602.59371711813, "unit": "score"}], "name": "dromaeo_css", "value": 7205.056542425971, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 105.0, 113.0, 111.0, 112.0, 106.0, 110.0, 116.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 151.0, 208.0, 130.0, 156.0, 148.0, 129.0, 176.0, 125.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 167.0, 165.0, 167.0, 163.0, 161.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 155.0, 77.0, 77.0, 76.0, 77.0, 166.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 184.0, 91.0, 93.0, 93.0, 156.0, 92.0, 92.0, 160.0], "value": 115.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 119.0, 118.0, 119.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 99.0, 98.0, 99.0, 100.0, 99.0, 97.0, 100.0, 100.0], "value": 98.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 60.0, 59.0, 64.0, 59.0, 58.0, 117.0, 57.0, 57.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 80.0, 80.0, 80.0, 83.0, 79.0, 79.0, 87.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 132.0, 123.0, 124.0, 125.0, 125.0, 127.0, 192.0, 126.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 169.0, 171.0, 169.0, 169.0, 166.0, 168.0, 170.0, 174.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 66.0, 73.0, 66.0, 67.0, 66.0, 64.0, 64.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1570.8999999999999, "alertThreshold": 2.0}]} 17:26:33 INFO - Return code: 0 17:26:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:26:33 ERROR - # TBPL SUCCESS # 17:26:33 INFO - Running post-action listener: _resource_record_post_action 17:26:33 INFO - ##### 17:26:33 INFO - ##### Finished run-tests step (success) 17:26:33 INFO - ##### 17:26:33 INFO - Running post-run listener: _resource_record_post_run 17:26:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 534814720; Read time: 0; Write time: 447344 17:26:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244809728; Read time: 0; Write time: 217988 17:26:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290004992; Read time: 0; Write time: 229356 17:26:34 INFO - Running post-run listener: _upload_blobber_files 17:26:34 INFO - Blob upload gear active. 17:26:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:26:34 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 17:26:34 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:26:34 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:26:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:26:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:35 INFO - (blobuploader) - INFO - Done attempting. 17:26:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:26:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:26:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:36 INFO - (blobuploader) - INFO - Done attempting. 17:26:36 INFO - (blobuploader) - INFO - Iteration through files over. 17:26:36 INFO - Return code: 0 17:26:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:26:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:26:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba447275edeb1e29400c79c8aeb5b917722d7d1f08df7c6fbd12da2e90afb25d17ab202f5c057c2d3fc7cc166612915040bd60a1c85b57436ff9c18e6be6d30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e7091d72bc1417b75efd6d4fa0bafd4cfa35605c2793f25236a1a73dc69e7760a1a70eb6bbca7b9fefc1af903d2759bf91ea29862ce7fd1d88cd29fcd9a80ac"} 17:26:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:26:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:26:36 INFO - Contents: 17:26:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba447275edeb1e29400c79c8aeb5b917722d7d1f08df7c6fbd12da2e90afb25d17ab202f5c057c2d3fc7cc166612915040bd60a1c85b57436ff9c18e6be6d30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e7091d72bc1417b75efd6d4fa0bafd4cfa35605c2793f25236a1a73dc69e7760a1a70eb6bbca7b9fefc1af903d2759bf91ea29862ce7fd1d88cd29fcd9a80ac"} 17:26:36 INFO - Running post-run listener: copy_logs_to_upload_dir 17:26:36 INFO - Copying logs to upload dir... 17:26:36 INFO - mkdir: /builds/slave/test/build/upload/logs 17:26:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.731348 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-10 17:26:35.293161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 17:26:35.296905) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364 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/Fx-Team/sha512/aba447275edeb1e29400c79c8aeb5b917722d7d1f08df7c6fbd12da2e90afb25d17ab202f5c057c2d3fc7cc166612915040bd60a1c85b57436ff9c18e6be6d30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e7091d72bc1417b75efd6d4fa0bafd4cfa35605c2793f25236a1a73dc69e7760a1a70eb6bbca7b9fefc1af903d2759bf91ea29862ce7fd1d88cd29fcd9a80ac"} build_url:https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba447275edeb1e29400c79c8aeb5b917722d7d1f08df7c6fbd12da2e90afb25d17ab202f5c057c2d3fc7cc166612915040bd60a1c85b57436ff9c18e6be6d30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e7091d72bc1417b75efd6d4fa0bafd4cfa35605c2793f25236a1a73dc69e7760a1a70eb6bbca7b9fefc1af903d2759bf91ea29862ce7fd1d88cd29fcd9a80ac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 17:26:35.321162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:26:35.321474) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1462924988.938874-152875364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:26:35.407544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 17:26:35.407856) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 17:26:35.408189) ========= ========= Total master_lag: 0.18 =========