builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1462925305.77 results: success (0) buildid: 20160510143005 builduid: d38a9ff5277f46c6b233f3622135e4df revision: ee562525573f8896fe4f7a5ac053de3d97ae4ccb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:25.774159) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:25.774879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:25.775365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:25.793800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:25.794283) ========= 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=574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 17:08:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-10 17:08:27 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095210 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:25.905331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:25.905864) ========= 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=574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016096 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:25.957900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:25.958474) ========= 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=574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 17:08:27,842 truncating revision to first 12 chars 2016-05-10 17:08:27,842 Setting DEBUG logging. 2016-05-10 17:08:27,842 attempt 1/10 2016-05-10 17:08:27,842 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:08:28,290 unpacking tar archive at: fx-team-ee562525573f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.722064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:26.694632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:26.694960) ========= script_repo_revision: ee562525573f8896fe4f7a5ac053de3d97ae4ccb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:26.695375) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:26.695671) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 17:08:26.705232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-10 17:08:26.705620) ========= /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=574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:08:28 INFO - MultiFileLogger online at 20160510 17:08:28 in /builds/slave/test 17:08:28 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:08:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:28 INFO - {'append_to_log': False, 17:08:28 INFO - 'base_work_dir': '/builds/slave/test', 17:08:28 INFO - 'blob_upload_branch': 'Fx-Team', 17:08:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:28 INFO - 'branch': 'Fx-Team', 17:08:28 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:28 INFO - 'config_files': ('talos/linux_config.py',), 17:08:28 INFO - 'default_actions': ('clobber', 17:08:28 INFO - 'read-buildbot-config', 17:08:28 INFO - 'download-and-extract', 17:08:28 INFO - 'populate-webroot', 17:08:28 INFO - 'create-virtualenv', 17:08:28 INFO - 'install', 17:08:28 INFO - 'run-tests'), 17:08:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:28 INFO - 'download_minidump_stackwalk': True, 17:08:28 INFO - 'download_symbols': 'ondemand', 17:08:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:28 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:28 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:28 INFO - 'installer_path': 'installer.exe', 17:08:28 INFO - 'log_level': 'info', 17:08:28 INFO - 'log_name': 'talos', 17:08:28 INFO - 'log_to_console': True, 17:08:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:08:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:08:28 INFO - 'opt_config_files': (), 17:08:28 INFO - 'pip_index': False, 17:08:28 INFO - 'sps_profile': False, 17:08:28 INFO - 'sps_profile_interval': 0, 17:08:28 INFO - 'suite': 'dromaeojs-e10s', 17:08:28 INFO - 'system_bits': '32', 17:08:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:28 INFO - 'title': 'talos-linux64-ix-044', 17:08:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:28 INFO - 'use_talos_json': True, 17:08:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:28 INFO - 'work_dir': 'build'} 17:08:28 INFO - ##### 17:08:28 INFO - ##### Running clobber step. 17:08:28 INFO - ##### 17:08:28 INFO - Running pre-action listener: _resource_record_pre_action 17:08:28 INFO - Running main action method: clobber 17:08:28 INFO - rmtree: /builds/slave/test/build 17:08:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:29 INFO - Running post-action listener: _resource_record_post_action 17:08:29 INFO - ##### 17:08:29 INFO - ##### Finished clobber step (success) 17:08:29 INFO - ##### 17:08:29 INFO - ##### 17:08:29 INFO - ##### Running read-buildbot-config step. 17:08:29 INFO - ##### 17:08:29 INFO - Running pre-action listener: _resource_record_pre_action 17:08:29 INFO - Running main action method: read_buildbot_config 17:08:29 INFO - Using buildbot properties: 17:08:29 INFO - { 17:08:29 INFO - "project": "", 17:08:29 INFO - "product": "firefox", 17:08:29 INFO - "script_repo_revision": "production", 17:08:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:08:29 INFO - "repository": "", 17:08:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:08:29 INFO - "buildid": "20160510143005", 17:08:29 INFO - "pgo_build": "True", 17:08:29 INFO - "basedir": "/builds/slave/test", 17:08:29 INFO - "buildnumber": 309, 17:08:29 INFO - "slavename": "talos-linux64-ix-044", 17:08:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:08:29 INFO - "platform": "ubuntu64_hw", 17:08:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:08:29 INFO - "branch": "fx-team", 17:08:29 INFO - "repo_path": "integration/fx-team", 17:08:29 INFO - "revision": "ee562525573f8896fe4f7a5ac053de3d97ae4ccb", 17:08:29 INFO - "stage_platform": "linux64-pgo", 17:08:29 INFO - "builduid": "d38a9ff5277f46c6b233f3622135e4df", 17:08:29 INFO - "slavebuilddir": "test" 17:08:29 INFO - } 17:08:29 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:08:29 INFO - Running post-action listener: _resource_record_post_action 17:08:29 INFO - ##### 17:08:29 INFO - ##### Finished read-buildbot-config step (success) 17:08:29 INFO - ##### 17:08:29 INFO - ##### 17:08:29 INFO - ##### Running download-and-extract step. 17:08:29 INFO - ##### 17:08:29 INFO - Running pre-action listener: _resource_record_pre_action 17:08:29 INFO - Running main action method: download_and_extract 17:08:29 INFO - mkdir: /builds/slave/test/build/tests 17:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 INFO - Downloaded 1361 bytes. 17:08:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:08:29 INFO - Using the following test package requirements: 17:08:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:08:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:08:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:29 INFO - u'jsshell-linux-x86_64.zip'], 17:08:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:08:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:08:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:08:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:08:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:08:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:30 INFO - Downloaded 23898689 bytes. 17:08:30 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:08:30 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:08:32 INFO - Return code: 0 17:08:32 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:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:32 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:08:32 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:08:32 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:08:32 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:08:32 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:08:33 INFO - Downloaded 23898689 bytes. 17:08:33 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:08:33 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:08:35 INFO - Return code: 0 17:08: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:08:35 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:08:35 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:08:35 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:08:35 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:08:35 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:08:36 INFO - Downloaded 10840152 bytes. 17:08:36 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:08:36 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:08:36 INFO - Return code: 0 17:08:36 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:08:36 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:08:36 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:08:36 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:08:36 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:08:36 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:08:39 INFO - Downloaded 58352588 bytes. 17:08:39 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:08:39 INFO - mkdir: /builds/slave/test/properties 17:08:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:39 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:39 INFO - Contents: 17:08:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Ex92WkRYTiK0vkUhLI2iZw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:08:40 INFO - Running post-action listener: _resource_record_post_action 17:08:40 INFO - Running post-action listener: set_extra_try_arguments 17:08:40 INFO - ##### 17:08:40 INFO - ##### Finished download-and-extract step (success) 17:08:40 INFO - ##### 17:08:40 INFO - ##### 17:08:40 INFO - ##### Running populate-webroot step. 17:08:40 INFO - ##### 17:08:40 INFO - Running pre-action listener: _resource_record_pre_action 17:08:40 INFO - Running main action method: populate_webroot 17:08:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:40 INFO - '--tppagecycles', 17:08:40 INFO - '7'], 17:08:40 INFO - 'tests': ['tsvgm']}}, 17:08:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:08:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:08:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:08:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:40 INFO - 'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:40 INFO - 'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['damp', 'tps']}, 17:08:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:40 INFO - 'tests': ['damp', 'tps']}, 17:08:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['dromaeo_dom']}, 17:08:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['a11yr', 17:08:40 INFO - 'ts_paint', 17:08:40 INFO - 'tpaint', 17:08:40 INFO - 'sessionrestore', 17:08:40 INFO - 'sessionrestore_no_auto_restore', 17:08:40 INFO - 'tabpaint']}, 17:08:40 INFO - 'other-e10s': {'tests': ['a11yr', 17:08:40 INFO - 'ts_paint', 17:08:40 INFO - 'tpaint', 17:08:40 INFO - 'sessionrestore', 17:08:40 INFO - 'sessionrestore_no_auto_restore', 17:08:40 INFO - 'tabpaint']}, 17:08:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:08:40 INFO - 'ts_paint', 17:08:40 INFO - 'tpaint', 17:08:40 INFO - 'sessionrestore', 17:08:40 INFO - 'sessionrestore_no_auto_restore', 17:08:40 INFO - 'tabpaint']}, 17:08:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:08:40 INFO - 'ts_paint', 17:08:40 INFO - 'tpaint', 17:08:40 INFO - 'sessionrestore', 17:08:40 INFO - 'sessionrestore_no_auto_restore', 17:08:40 INFO - 'tabpaint']}, 17:08:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['a11yr', 17:08:40 INFO - 'ts_paint', 17:08:40 INFO - 'tpaint', 17:08:40 INFO - 'sessionrestore', 17:08:40 INFO - 'sessionrestore_no_auto_restore', 17:08:40 INFO - 'tabpaint']}, 17:08:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['a11yr', 17:08:40 INFO - 'ts_paint', 17:08:40 INFO - 'tpaint', 17:08:40 INFO - 'sessionrestore', 17:08:40 INFO - 'sessionrestore_no_auto_restore', 17:08:40 INFO - 'tabpaint']}, 17:08:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['tsvgx', 17:08:40 INFO - 'tsvgr_opacity', 17:08:40 INFO - 'tart', 17:08:40 INFO - 'tscrollx', 17:08:40 INFO - 'cart']}, 17:08:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:08:40 INFO - 'tsvgr_opacity', 17:08:40 INFO - 'tart', 17:08:40 INFO - 'tscrollx', 17:08:40 INFO - 'cart']}, 17:08:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:40 INFO - 'talos_options': ['--disable-e10s'], 17:08:40 INFO - 'tests': ['tp5o']}, 17:08:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:40 INFO - 'tests': ['tp5o']}, 17:08:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:40 INFO - 'talos_options': ['--disable-e10s', 17:08:40 INFO - '--xperf_path', 17:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:40 INFO - 'tests': ['tp5n']}, 17:08:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:40 INFO - 'talos_options': ['--xperf_path', 17:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:40 INFO - 'tests': ['tp5n']}}, 17:08:40 INFO - 'talos.zip': {'path': '', 17:08:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:40 INFO - Running post-action listener: _resource_record_post_action 17:08:40 INFO - ##### 17:08:40 INFO - ##### Finished populate-webroot step (success) 17:08:40 INFO - ##### 17:08:40 INFO - ##### 17:08:40 INFO - ##### Running create-virtualenv step. 17:08:40 INFO - ##### 17:08:40 INFO - Running pre-action listener: _resource_record_pre_action 17:08:40 INFO - Running main action method: create_virtualenv 17:08:40 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:40 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:08:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:40 INFO - Using real prefix '/usr' 17:08:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:41 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:43 INFO - Installing pip.................done. 17:08:43 INFO - Return code: 0 17:08:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36bb857f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ae770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, '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': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', '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:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:08:43 INFO - Using env: {'DISPLAY': ':0', 17:08:43 INFO - 'HOME': '/home/cltbld', 17:08:43 INFO - 'LANG': 'en_US.UTF-8', 17:08:43 INFO - 'LANGUAGE': 'en_US:en', 17:08:43 INFO - 'LOGNAME': 'cltbld', 17:08:43 INFO - 'MAIL': '/var/mail/cltbld', 17:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:43 INFO - 'MOZ_NO_REMOTE': '1', 17:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:43 INFO - 'NO_EM_RESTART': '1', 17:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:43 INFO - 'PWD': '/builds/slave/test', 17:08:43 INFO - 'SHELL': '/bin/bash', 17:08:43 INFO - 'SHLVL': '1', 17:08:43 INFO - 'TERM': 'linux', 17:08:43 INFO - 'TMOUT': '86400', 17:08:43 INFO - 'USER': 'cltbld', 17:08:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:43 INFO - '_': '/tools/buildbot/bin/python'} 17:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:43 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:08:43 INFO - Cleaning up... 17:08:43 INFO - Return code: 0 17:08:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f36bb857f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ae770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, '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': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', '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:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:08:43 INFO - Using env: {'DISPLAY': ':0', 17:08:43 INFO - 'HOME': '/home/cltbld', 17:08:43 INFO - 'LANG': 'en_US.UTF-8', 17:08:43 INFO - 'LANGUAGE': 'en_US:en', 17:08:43 INFO - 'LOGNAME': 'cltbld', 17:08:43 INFO - 'MAIL': '/var/mail/cltbld', 17:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:43 INFO - 'MOZ_NO_REMOTE': '1', 17:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:43 INFO - 'NO_EM_RESTART': '1', 17:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:43 INFO - 'PWD': '/builds/slave/test', 17:08:43 INFO - 'SHELL': '/bin/bash', 17:08:43 INFO - 'SHLVL': '1', 17:08:43 INFO - 'TERM': 'linux', 17:08:43 INFO - 'TMOUT': '86400', 17:08:43 INFO - 'USER': 'cltbld', 17:08:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:43 INFO - '_': '/tools/buildbot/bin/python'} 17:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:43 INFO - Downloading/unpacking psutil>=0.7.1 17:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:45 INFO - Installing collected packages: psutil 17:08:45 INFO - Running setup.py install for psutil 17:08:45 INFO - building 'psutil._psutil_linux' extension 17:08:45 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:08:45 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:08:45 INFO - building 'psutil._psutil_posix' extension 17:08:45 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:08:45 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:08:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:46 INFO - Successfully installed psutil 17:08:46 INFO - Cleaning up... 17:08:46 INFO - Return code: 0 17:08:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:46 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 0x7f36bb857f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ae770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, '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': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', '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:08:46 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:08:46 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:08:46 INFO - Using env: {'DISPLAY': ':0', 17:08:46 INFO - 'HOME': '/home/cltbld', 17:08:46 INFO - 'LANG': 'en_US.UTF-8', 17:08:46 INFO - 'LANGUAGE': 'en_US:en', 17:08:46 INFO - 'LOGNAME': 'cltbld', 17:08:46 INFO - 'MAIL': '/var/mail/cltbld', 17:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:46 INFO - 'MOZ_NO_REMOTE': '1', 17:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:46 INFO - 'NO_EM_RESTART': '1', 17:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:46 INFO - 'PWD': '/builds/slave/test', 17:08:46 INFO - 'SHELL': '/bin/bash', 17:08:46 INFO - 'SHLVL': '1', 17:08:46 INFO - 'TERM': 'linux', 17:08:46 INFO - 'TMOUT': '86400', 17:08:46 INFO - 'USER': 'cltbld', 17:08:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:46 INFO - '_': '/tools/buildbot/bin/python'} 17:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:08:46 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:08:46 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:08:46 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:08:46 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:08:46 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:08:46 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:08:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:48 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:08:48 INFO - Installing collected packages: mozsystemmonitor 17:08:48 INFO - Running setup.py install for mozsystemmonitor 17:08:48 INFO - Successfully installed mozsystemmonitor 17:08:48 INFO - Cleaning up... 17:08:48 INFO - Return code: 0 17:08:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f36bb857f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ae770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, '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': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', '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:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:08:48 INFO - Using env: {'DISPLAY': ':0', 17:08:48 INFO - 'HOME': '/home/cltbld', 17:08:48 INFO - 'LANG': 'en_US.UTF-8', 17:08:48 INFO - 'LANGUAGE': 'en_US:en', 17:08:48 INFO - 'LOGNAME': 'cltbld', 17:08:48 INFO - 'MAIL': '/var/mail/cltbld', 17:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:48 INFO - 'MOZ_NO_REMOTE': '1', 17:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:48 INFO - 'NO_EM_RESTART': '1', 17:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:48 INFO - 'PWD': '/builds/slave/test', 17:08:48 INFO - 'SHELL': '/bin/bash', 17:08:48 INFO - 'SHLVL': '1', 17:08:48 INFO - 'TERM': 'linux', 17:08:48 INFO - 'TMOUT': '86400', 17:08:48 INFO - 'USER': 'cltbld', 17:08:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:48 INFO - '_': '/tools/buildbot/bin/python'} 17:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:48 INFO - Downloading/unpacking blobuploader==1.2.4 17:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:08:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:08:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:51 INFO - Downloading docopt-0.6.1.tar.gz 17:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:08:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:08:51 INFO - Running setup.py install for blobuploader 17:08:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:08:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:08:51 INFO - Running setup.py install for requests 17:08:51 INFO - Running setup.py install for docopt 17:08:51 INFO - Successfully installed blobuploader requests docopt 17:08:51 INFO - Cleaning up... 17:08:51 INFO - Return code: 0 17:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:51 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:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:51 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:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:51 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 0x7f36bb857f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ae770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, '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': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', '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:08:51 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:08:51 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:08:51 INFO - Using env: {'DISPLAY': ':0', 17:08:51 INFO - 'HOME': '/home/cltbld', 17:08:51 INFO - 'LANG': 'en_US.UTF-8', 17:08:51 INFO - 'LANGUAGE': 'en_US:en', 17:08:51 INFO - 'LOGNAME': 'cltbld', 17:08:51 INFO - 'MAIL': '/var/mail/cltbld', 17:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:51 INFO - 'MOZ_NO_REMOTE': '1', 17:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:51 INFO - 'NO_EM_RESTART': '1', 17:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:51 INFO - 'PWD': '/builds/slave/test', 17:08:51 INFO - 'SHELL': '/bin/bash', 17:08:51 INFO - 'SHLVL': '1', 17:08:51 INFO - 'TERM': 'linux', 17:08:51 INFO - 'TMOUT': '86400', 17:08:51 INFO - 'USER': 'cltbld', 17:08:51 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:51 INFO - '_': '/tools/buildbot/bin/python'} 17:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:52 INFO - Running setup.py (path:/tmp/pip-8_u7zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:52 INFO - Running setup.py (path:/tmp/pip-f6fAHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:52 INFO - Running setup.py (path:/tmp/pip-bvI6Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:52 INFO - Running setup.py (path:/tmp/pip-LvvskB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:52 INFO - Running setup.py (path:/tmp/pip-MAVm2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:52 INFO - Running setup.py (path:/tmp/pip-eVDZqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:52 INFO - Running setup.py (path:/tmp/pip-S0a4LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:52 INFO - Running setup.py (path:/tmp/pip-2noL14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:52 INFO - Running setup.py (path:/tmp/pip-NS6uE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:52 INFO - Running setup.py (path:/tmp/pip-7ftztK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:52 INFO - Running setup.py (path:/tmp/pip-xGwtJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:52 INFO - Running setup.py (path:/tmp/pip-JzMqRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:52 INFO - Running setup.py (path:/tmp/pip-F_T4pM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:53 INFO - Running setup.py (path:/tmp/pip-ACW_Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:53 INFO - Running setup.py (path:/tmp/pip-vnl3Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:53 INFO - Running setup.py (path:/tmp/pip-VE3TSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:53 INFO - Running setup.py (path:/tmp/pip-ttWek3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:53 INFO - Running setup.py install for manifestparser 17:08:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:08:53 INFO - Running setup.py install for mozcrash 17:08:53 INFO - Running setup.py install for mozdebug 17:08:53 INFO - Running setup.py install for mozdevice 17:08:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:08:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:08:53 INFO - Running setup.py install for mozfile 17:08:53 INFO - Running setup.py install for mozhttpd 17:08:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:08:53 INFO - Running setup.py install for mozinfo 17:08:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Running setup.py install for mozInstall 17:08:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Running setup.py install for mozleak 17:08:54 INFO - Running setup.py install for mozlog 17:08:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Running setup.py install for moznetwork 17:08:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Running setup.py install for mozprocess 17:08:54 INFO - Running setup.py install for mozprofile 17:08:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Running setup.py install for mozrunner 17:08:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:54 INFO - Running setup.py install for mozscreenshot 17:08:54 INFO - Running setup.py install for moztest 17:08:54 INFO - Running setup.py install for mozversion 17:08:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:55 INFO - Cleaning up... 17:08:55 INFO - Return code: 0 17:08:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:55 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:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:55 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:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:55 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 0x7f36bb857f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ae770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, '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': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', '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:08:55 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:08:55 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:08:55 INFO - Using env: {'DISPLAY': ':0', 17:08:55 INFO - 'HOME': '/home/cltbld', 17:08:55 INFO - 'LANG': 'en_US.UTF-8', 17:08:55 INFO - 'LANGUAGE': 'en_US:en', 17:08:55 INFO - 'LOGNAME': 'cltbld', 17:08:55 INFO - 'MAIL': '/var/mail/cltbld', 17:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:55 INFO - 'MOZ_NO_REMOTE': '1', 17:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:55 INFO - 'NO_EM_RESTART': '1', 17:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:55 INFO - 'PWD': '/builds/slave/test', 17:08:55 INFO - 'SHELL': '/bin/bash', 17:08:55 INFO - 'SHLVL': '1', 17:08:55 INFO - 'TERM': 'linux', 17:08:55 INFO - 'TMOUT': '86400', 17:08:55 INFO - 'USER': 'cltbld', 17:08:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:55 INFO - '_': '/tools/buildbot/bin/python'} 17:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:55 INFO - Running setup.py (path:/tmp/pip-B9lMF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:55 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:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:55 INFO - Running setup.py (path:/tmp/pip-_aBFwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:55 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:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:55 INFO - Running setup.py (path:/tmp/pip-tzxiQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:55 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:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:55 INFO - Running setup.py (path:/tmp/pip-xaWmnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:55 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:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:55 INFO - Running setup.py (path:/tmp/pip-ZN06Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:55 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:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:55 INFO - Running setup.py (path:/tmp/pip-JEXd0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:55 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:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:55 INFO - Running setup.py (path:/tmp/pip-pGQW5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:55 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:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:55 INFO - Running setup.py (path:/tmp/pip-X6DsfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:55 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:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:55 INFO - Running setup.py (path:/tmp/pip-ju3aEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:55 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:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:55 INFO - Running setup.py (path:/tmp/pip-3s58Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:56 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:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:56 INFO - Running setup.py (path:/tmp/pip-uYLrAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:56 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:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:56 INFO - Running setup.py (path:/tmp/pip-m8PYmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:56 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:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:56 INFO - Running setup.py (path:/tmp/pip-tMh4yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:56 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:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:56 INFO - Running setup.py (path:/tmp/pip-CAMdLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:56 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:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:56 INFO - Running setup.py (path:/tmp/pip-E7IiSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:56 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:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:56 INFO - Running setup.py (path:/tmp/pip-uIhP9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:56 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:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:56 INFO - Running setup.py (path:/tmp/pip-VdIkqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:56 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:08:56 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:08:56 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:08:56 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:08:56 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:08:56 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:08:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:58 INFO - Downloading blessings-1.6.tar.gz 17:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:58 INFO - Installing collected packages: blessings 17:08:58 INFO - Running setup.py install for blessings 17:08:58 INFO - Successfully installed blessings 17:08:58 INFO - Cleaning up... 17:08:58 INFO - Return code: 0 17:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:58 INFO - Reading from file tmpfile_stdout 17:08:58 INFO - Current package versions: 17:08:58 INFO - argparse == 1.2.1 17:08:58 INFO - blessings == 1.6 17:08:58 INFO - blobuploader == 1.2.4 17:08:58 INFO - docopt == 0.6.1 17:08:58 INFO - manifestparser == 1.1 17:08:58 INFO - mozInstall == 1.12 17:08:58 INFO - mozcrash == 0.17 17:08:58 INFO - mozdebug == 0.1 17:08:58 INFO - mozdevice == 0.48 17:08:58 INFO - mozfile == 1.2 17:08:58 INFO - mozhttpd == 0.7 17:08:58 INFO - mozinfo == 0.9 17:08:58 INFO - mozleak == 0.1 17:08:58 INFO - mozlog == 3.1 17:08:58 INFO - moznetwork == 0.27 17:08:58 INFO - mozprocess == 0.22 17:08:58 INFO - mozprofile == 0.28 17:08:58 INFO - mozrunner == 6.11 17:08:58 INFO - mozscreenshot == 0.1 17:08:58 INFO - mozsystemmonitor == 0.0 17:08:58 INFO - moztest == 0.7 17:08:58 INFO - mozversion == 1.4 17:08:58 INFO - psutil == 3.1.1 17:08:58 INFO - requests == 1.2.3 17:08:58 INFO - wsgiref == 0.1.2 17:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08: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:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:58 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 0x7f36bb857f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ae770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, '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': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', '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:08:58 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:08:58 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:08:58 INFO - Using env: {'DISPLAY': ':0', 17:08:58 INFO - 'HOME': '/home/cltbld', 17:08:58 INFO - 'LANG': 'en_US.UTF-8', 17:08:58 INFO - 'LANGUAGE': 'en_US:en', 17:08:58 INFO - 'LOGNAME': 'cltbld', 17:08:58 INFO - 'MAIL': '/var/mail/cltbld', 17:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:58 INFO - 'MOZ_NO_REMOTE': '1', 17:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:58 INFO - 'NO_EM_RESTART': '1', 17:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:58 INFO - 'PWD': '/builds/slave/test', 17:08:58 INFO - 'SHELL': '/bin/bash', 17:08:58 INFO - 'SHLVL': '1', 17:08:58 INFO - 'TERM': 'linux', 17:08:58 INFO - 'TMOUT': '86400', 17:08:58 INFO - 'USER': 'cltbld', 17:08:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:58 INFO - '_': '/tools/buildbot/bin/python'} 17:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 INFO - Cleaning up... 17:08:59 INFO - Return code: 0 17:08:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:08:59 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:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:59 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:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:59 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 0x7f36bb857f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ae770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, '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': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', '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:08:59 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:08:59 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:08:59 INFO - Using env: {'DISPLAY': ':0', 17:08:59 INFO - 'HOME': '/home/cltbld', 17:08:59 INFO - 'LANG': 'en_US.UTF-8', 17:08:59 INFO - 'LANGUAGE': 'en_US:en', 17:08:59 INFO - 'LOGNAME': 'cltbld', 17:08:59 INFO - 'MAIL': '/var/mail/cltbld', 17:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:59 INFO - 'MOZ_NO_REMOTE': '1', 17:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:59 INFO - 'NO_EM_RESTART': '1', 17:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:59 INFO - 'PWD': '/builds/slave/test', 17:08:59 INFO - 'SHELL': '/bin/bash', 17:08:59 INFO - 'SHLVL': '1', 17:08:59 INFO - 'TERM': 'linux', 17:08:59 INFO - 'TMOUT': '86400', 17:08:59 INFO - 'USER': 'cltbld', 17:08:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:59 INFO - '_': '/tools/buildbot/bin/python'} 17:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:59 INFO - Downloading/unpacking jsonschema 17:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:01 INFO - Downloading/unpacking functools32 (from jsonschema) 17:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:01 INFO - warning: no files found matching '*.txt' 17:09:01 INFO - no previously-included directories found matching 'build' 17:09:01 INFO - no previously-included directories found matching 'dist' 17:09:01 INFO - no previously-included directories found matching '.git*' 17:09:01 INFO - Installing collected packages: jsonschema, functools32 17:09:01 INFO - Running setup.py install for functools32 17:09:01 INFO - warning: no files found matching '*.txt' 17:09:01 INFO - no previously-included directories found matching 'build' 17:09:01 INFO - no previously-included directories found matching 'dist' 17:09:01 INFO - no previously-included directories found matching '.git*' 17:09:01 INFO - Successfully installed jsonschema functools32 17:09:01 INFO - Cleaning up... 17:09:01 INFO - Return code: 0 17:09:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:09: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:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:01 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 0x7f36bb857f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ae770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, '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': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', '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:09:01 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:09:01 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:09:01 INFO - Using env: {'DISPLAY': ':0', 17:09:01 INFO - 'HOME': '/home/cltbld', 17:09:01 INFO - 'LANG': 'en_US.UTF-8', 17:09:01 INFO - 'LANGUAGE': 'en_US:en', 17:09:01 INFO - 'LOGNAME': 'cltbld', 17:09:01 INFO - 'MAIL': '/var/mail/cltbld', 17:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:01 INFO - 'MOZ_NO_REMOTE': '1', 17:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:01 INFO - 'NO_EM_RESTART': '1', 17:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:01 INFO - 'PWD': '/builds/slave/test', 17:09:01 INFO - 'SHELL': '/bin/bash', 17:09:01 INFO - 'SHLVL': '1', 17:09:01 INFO - 'TERM': 'linux', 17:09:01 INFO - 'TMOUT': '86400', 17:09:01 INFO - 'USER': 'cltbld', 17:09:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:01 INFO - '_': '/tools/buildbot/bin/python'} 17:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:01 INFO - Downloading/unpacking flake8 17:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:09:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:09:03 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:09:03 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:09:03 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:09:03 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:09:03 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:09:03 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:09:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:09:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:09:03 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:09:03 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:09:03 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:09:03 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:09:03 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:09:03 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:09:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:04 INFO - no previously-included directories found matching 'docs/_build' 17:09:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:09:04 INFO - Running setup.py install for pep8 17:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:04 INFO - no previously-included directories found matching 'docs/_build' 17:09:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:09:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:09:04 INFO - Cleaning up... 17:09:04 INFO - Return code: 0 17:09:04 INFO - Running post-action listener: _resource_record_post_action 17:09:04 INFO - Running post-action listener: _start_resource_monitoring 17:09:04 INFO - Starting resource monitoring. 17:09:04 INFO - ##### 17:09:04 INFO - ##### Finished create-virtualenv step (success) 17:09:04 INFO - ##### 17:09:04 INFO - ##### 17:09:04 INFO - ##### Running install step. 17:09:04 INFO - ##### 17:09:04 INFO - Running pre-action listener: _resource_record_pre_action 17:09:04 INFO - Running main action method: install 17:09:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:05 INFO - Reading from file tmpfile_stdout 17:09:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:05 INFO - Reading from file tmpfile_stdout 17:09:05 INFO - Output received: 17:09:05 INFO - Usage: mozinstall [options] installer 17:09:05 INFO - Options: 17:09:05 INFO - -h, --help show this help message and exit 17:09:05 INFO - -d DEST, --destination=DEST 17:09:05 INFO - Directory to install application into. [default: 17:09:05 INFO - "/builds/slave/test"] 17:09:05 INFO - --app=APP Application being installed. [default: firefox] 17:09:05 INFO - mkdir: /builds/slave/test/build/application 17:09:05 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:09:05 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:09:21 INFO - Reading from file tmpfile_stdout 17:09:21 INFO - Output received: 17:09:21 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:21 INFO - Running post-action listener: _resource_record_post_action 17:09:21 INFO - ##### 17:09:21 INFO - ##### Finished install step (success) 17:09:21 INFO - ##### 17:09:21 INFO - ##### 17:09:21 INFO - ##### Running run-tests step. 17:09:21 INFO - ##### 17:09:21 INFO - Running pre-action listener: _resource_record_pre_action 17:09:21 INFO - Running main action method: run_tests 17:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:21 INFO - Python 2.7.3 17:09:21 INFO - Return code: 0 17:09:21 INFO - grabbing minidump binary from tooltool 17:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:21 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 0x283d9c0>, '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 0x283e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:21 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:09:21 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:09:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:21 INFO - Return code: 0 17:09:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:09:22 INFO - Return code: 0 17:09:22 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-044', '--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:09:22 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-044 --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:09:22 INFO - Using env: {'DISPLAY': ':0', 17:09:22 INFO - 'HOME': '/home/cltbld', 17:09:22 INFO - 'LANG': 'en_US.UTF-8', 17:09:22 INFO - 'LANGUAGE': 'en_US:en', 17:09:22 INFO - 'LOGNAME': 'cltbld', 17:09:22 INFO - 'MAIL': '/var/mail/cltbld', 17:09:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:22 INFO - 'MOZ_NO_REMOTE': '1', 17:09:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:22 INFO - 'NO_EM_RESTART': '1', 17:09:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:22 INFO - 'PWD': '/builds/slave/test', 17:09:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:22 INFO - 'SHELL': '/bin/bash', 17:09:22 INFO - 'SHLVL': '1', 17:09:22 INFO - 'TERM': 'linux', 17:09:22 INFO - 'TMOUT': '86400', 17:09:22 INFO - 'USER': 'cltbld', 17:09:22 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434', 17:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:22 INFO - '_': '/tools/buildbot/bin/python'} 17:09:22 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-044', '--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:09:22 INFO - mozversion application_buildid: 20160510143005 17:09:22 INFO - mozversion application_changeset: ee562525573f8896fe4f7a5ac053de3d97ae4ccb 17:09:22 INFO - mozversion application_display_name: Nightly 17:09:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:22 INFO - mozversion application_name: Firefox 17:09:22 INFO - mozversion application_remotingname: firefox 17:09:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:09:23 INFO - mozversion application_vendor: Mozilla 17:09:23 INFO - mozversion application_version: 49.0a1 17:09:23 INFO - mozversion platform_buildid: 20160510143005 17:09:23 INFO - mozversion platform_changeset: ee562525573f8896fe4f7a5ac053de3d97ae4ccb 17:09:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:09:23 INFO - mozversion platform_version: 49.0a1 17:09:23 INFO - using testdate: 1462925362 17:09:23 INFO - actual date: 1462925362 17:09:23 INFO - starting webserver on 'localhost:34368' 17:09:23 INFO - SUITE-START | Running 2 tests 17:09:23 INFO - TEST-START | dromaeo_css 17:09:23 INFO - operating with platform_type : linux_ 17:09:23 INFO - Initialising browser for dromaeo_css test... 17:09:23 INFO - TEST-INFO | started process 27912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV66UUD/profile http://localhost:34368/getInfo.html) 17:09:26 INFO - PROCESS | 27912 | 17:09:26 INFO - PROCESS | 27912 | (process:27981): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:27 INFO - PROCESS | 27912 | __metrics Screen width/height:1600/1200 17:09:27 INFO - PROCESS | 27912 | colorDepth:24 17:09:27 INFO - PROCESS | 27912 | Browser inner width/height: 1024/697 17:09:27 INFO - PROCESS | 27912 | __metrics 17:09:28 ERROR - PROCESS | 27912 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:09:29 INFO - TEST-INFO | 27912: exit 0 17:09:29 INFO - Browser initialized. 17:09:29 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:29 INFO - TEST-INFO | started process 28032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV66UUD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:30 INFO - PROCESS | 28032 | 17:09:30 INFO - PROCESS | 28032 | (process:28093): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:40 INFO - PROCESS | 28032 | RSS: Main: 163225600 17:09:40 INFO - PROCESS | 28032 | 17:10:30 INFO - PROCESS | 28032 | 1462925430584 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:12:38 INFO - PROCESS | 28032 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34368/tests/dromaeo/cssquery-ext.html) 17:12:39 INFO - PROCESS | 28032 | RSS: Main: 166457344 17:12:39 INFO - PROCESS | 28032 | 17:15:41 INFO - PROCESS | 28032 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-ext.html (next: http://localhost:34368/tests/dromaeo/cssquery-jquery.html) 17:15:42 INFO - PROCESS | 28032 | RSS: Main: 166604800 17:15:42 INFO - PROCESS | 28032 | 17:18:44 INFO - PROCESS | 28032 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34368/tests/dromaeo/cssquery-mootools.html) 17:18:44 INFO - PROCESS | 28032 | RSS: Main: 167534592 17:18:44 INFO - PROCESS | 28032 | 17:21:46 INFO - PROCESS | 28032 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34368/tests/dromaeo/cssquery-prototype.html) 17:21:47 INFO - PROCESS | 28032 | RSS: Main: 165535744 17:21:47 INFO - PROCESS | 28032 | 17:24:49 INFO - PROCESS | 28032 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34368/tests/dromaeo/cssquery-yui.html) 17:24:50 INFO - PROCESS | 28032 | RSS: Main: 166748160 17:24:50 INFO - PROCESS | 28032 | 17:27:52 INFO - PROCESS | 28032 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-yui.html (next: http://localhost:34368/tests/dromaeo/cssquery-dojo.html) 17:27:52 INFO - PROCESS | 28032 | RSS: Main: 168337408 17:27:52 INFO - PROCESS | 28032 | 17:27:52 INFO - PROCESS | 28032 | __start_tp_report 17:27:52 INFO - PROCESS | 28032 | _x_x_mozilla_page_load 17:27:52 INFO - PROCESS | 28032 | _x_x_mozilla_page_load_details 17:27:52 INFO - PROCESS | 28032 | |i|pagename|runs| 17:27:52 INFO - PROCESS | 28032 | |0;dojo.html;3132.5927629408175;3140.1678555182866;3147.795393299437;3178.300773829758;3200.951985720213;5353.705546194958;5383.46165383461;5385.380681221661;5487.890242195153;5544.251526043983;5419.458054194579;5531.557475401958;5534.059209934311;5577.414371490986;5588.888222235553;4923.6307276954285;5033.672811267256;5076.23856421536;5094.006668699605;5105.617078719092;4967.478414766451;5185.818496352628;5186.507281808241;5196.480351964811;5213.843584692465;4952.975235123801;4980.800767969295;4987.650864439491;5004.349434573519;5058.165402708549;5071.771770270347;5072.568831649314;5075;5083.847484575432;5148.4079330876675;4983.451820299764;5015.1975683890405;5026.220935754964;5026.974865125688;5051.545360917498;5388.973055134699;5397.460253974571;5411.161270003156;5420.430854760233;5488.725563721838;5925.970370148165;5933.110033494967;5949.405059494059;5966.3138739045135;5984.790532331347;5724.713764311768;5783.739731712083;5951.196588460546;5956.880862382772;5978.8505287367725;5505;5505.366882808488;5554.638948468337;5582.86042848932;5622.746976386073;6043.969780151071;6079.3920607939735;6140.140380346755;6143.784967526115;6144.139820425144;5709.800156994485;5741.540676745851;5875.735591898289;5881.558883083786;5883.558733095035;5836.241288632451;5886.117082437669;5893.911591326134;5899.734511946973;5949.940500594938;5784.913226301609;5844.532437404998;5845.7369418376275;5866.794662186889;5882.911756323659;5689.687067211343;5894.115882617556;5979.850503737442;5986;5989.161517387569;4429;4447.199504089295;4465.0400163964905;4487.798049087799;4492;3999.7200195986;4004.5795191505053;4009.959900401017;4031.7580945143386;4044.1102957349926;5558.805441809598;5633.211350410946;5636.18275350072;5647.661140331511;5651.095824668033;5996.580239383288;6097.185685213644;6102.51954821894;6103.943827031755;6106.695694098542;5673.517750991212;5729.0260655688635;5743.569232307594;5758.62568933018;5796.913046304308;4763.190257656207;4892.046051020088;4903.068417000758;4974.77613507393;4992.775325110306;6233.812985610439;6237.438630523275;6247.625142491465;6247.812565623039;6258.123862659231;5925.288965324189;5980.850478738066;6022.223444083918;6024;6101.054336577838;5917.437843404869;6075.665838378932;6098.583513185022;6119.724612392542;6216.595921265103;5781.306243250837;5821.76712931495;5847.473727364558;5852.619579727304;5862.824115276549;5927.436893495111;5971.611845230046;5981.222441082631;5998.370171132143;5998.970005149947;5563.749631266522;5598.384177740527;5746.569007324551;5754.683492407958;5782.739776709974;5602.9719851402115;5667.40492248308;5674.120511320752;5701.543876489954;5722.370539240597;5587.385387607279;5591.496765291144;5609.579281553818;5662.094064949753;5676.77292908279;5716.056850619601;5825.446582574648;5909.556783241188;5962.165296858357;5962.314333851489;5815.2149459822385;5860.501857342174;5861.824145275648;5863.853403664943;5871.236739223874 17:27:52 INFO - PROCESS | 28032 | |1;ext.html;598.3597550620838;636.2238069555141;641.3490307338052;658.6245839871273;681.3493114076058;41325;42269.78865105674;42297.15405691892;42303.78848105755;42351;42912.57087429125;43663.78168109163;43727.56272437274;43830.34254486185;43885;8858.424202426853;8992.23565996891;9015.098490150966;9019.233365163936;9040.547972601376;8792.384533082686;8813.250873675714;8834.646614135427;8842.557872106401;8873.73378798637;8858;8904.020557738644;8904.643814247454;8923.063078376774;8955.731328060136;8740.388172827905;8831.161039701217;8832.735017949472;8834.602442890086;8864.024957254696;8735.519546424945;8818.955905220497;8856.070112638145;8857.512836793974;8887.200151986288;34491.482627760604;39764.403533947014;40225.59774402277;40234;40258.39612405816;3165.1454107391105;3225.951610725841;3391.3895498810202;3464.3071385722956;3498.3353162898966;30698;31076.369811697627;31205.531917021035;31511;31709;4059.3505039193587;4085.9387109193385;4140.979295103535;4143.268556421558;4223.176480586287;287448;288317;288679.9999999979;289777;290093;34146.317073658385;35278;36586;36845.26309473849;36953.26093478115;36601.81699091541;36788;36897.44653830195;36909.630903691155;36993.81503092467;16117.516474505783;16147.434839780552;16167.67664646724;16170.514884553248;16195.190240488164;13419.725126113004;13433.596992090253;13437.462501499831;13437.924966002696;13548.254845983565;8702.912970870337;8705.260052895448;8729.476231426135;8750.956245218733;8763.912360876437;3327.168207948013;3335.5997280326515;3357.3285342931513;3397.371486275047;3439.1574064354395;1027.3527677563088;1075.2795626929976;1118.5413980268052;1155.526234243956;1165.6561314412268;32187.51718724221;32360.514592281135;32947;33048.50427243593;33058.504122438186;1136.687410961992;1163.6334554615269;1234.1052736765773;1243.3969524780475;1250.4998000799571;17388.130593470276;17480.825191748176;17559.20983555743;17595.384161554284;17688.734668979974;489823;492532;496453;497363;500071;59029.70485147633;59220.40779592235;59518.70240648769;59567;59604;1372.7597670407638;1384.9099808512415;1394.5676840179576;1396.5182012205773;1406.866347696967;30997.53503697401;31365.686343136276;31649.525257121622;31801.8409907949;32780.1804954878;52080.47919520908;52884.73557632187;52947;52967.735161323944;53039.204411934625;382228;388312;390205;390857;391055;29043.709562904947;29336;29373.85313073421;29507.409851802415;29522.704772951995;48530.51469485401;50006;50108;51188.488115119864;51775.599074079124;41349.586504134575;41400.37899431451;41844;41858.37212441877;43027.784861075495;41842.163156737304;41893.79053104715;42087.579124208365;42303.3654495189;42913.35629965615;37387;41738.79130604328;42156.78921605495;42624.57375426206;42904.78547607242;35737.821310893276;36669;36722.7147049852;37077.07307317231;38225.808870955465;28497.572536411557;28804.279893002844;29439.705602943697;29464;31530.36939261248 17:27:52 INFO - PROCESS | 28032 | |2;jquery.html;410.28405432520276;411.2741012113618;419.7439561867262;421.515257453928;424.39735575482814;19229.423117306487;19396.1118163941;19656.739474960366;19794.10926508307;20369.694454583194;18748.43754687358;19102.90448547759;19282;19324;19437.902810485964;5496.1755736639525;5826.242588463515;5831.4751672349485;5850.0932355484965;5861.2087368205175;5514.834554963358;5696.287964004499;5801.738921748511;5807.854803629922;5819.30168379795;5727.284089488814;5730.283714535683;5737;5775.855603609902;5776.682282474462;5474.233607294982;5633.126865335838;5706.315242170946;5739.569532285095;5739.770409183628;5109.310243117169;5117.923231151536;5130.871728206825;5143.948560514385;5153.330067091291;22222.77777222223;22366;22608.886955565118;22849;22910;2273.1930164791593;2399.796017338528;2454.680891484096;2499.5875680512877;2643.035292118363;14105;14746;14908;14932.776008359884;15203.859710521756;1778.8754787164903;1826.8355847973746;1835.4952388093247;1841.4015444980434;1872.8595355348268;72760.6361968192;75117.6244118776;76253.23746762516;80214.79677804837;81931.18068819295;10944.781104377867;11194.440277986068;11505.194636375374;11556.479958401893;11670.124740644485;15996.840031599768;16074.357025719075;16173.4339298124;16194;16243.187840607923;8367.58162091905;8460.450070745383;8503.787405314793;8579.957100214458;8592.785180370542;8086.474379165335;8212;8290.668373265002;8315.168483151636;8371.121032291643;4863.1003264395495;4908;4949.752512374367;4957.677750946177;5003.72479513623;1998.8300994415347;2007.7574716832503;2068.979310206879;2091.7280753501946;2092.3199960012753;925.9259259259378;1018.5772904244656;1041.1358572384902;1116.0625074937093;1134.9886501135047;17308.65382692339;19536.902315488616;19609.509762255773;19610.8038919609;19807.405777826687;1034.5706531789374;1035.7773078787945;1046.9214808889365;1095.46322302073;1098.5770478365887;10624.681259562225;10821.891781082246;11026.779464410667;11103.83344249837;11156.219064665396;453919;455435;465722;466581;472768;92606.53696731474;93840.53079734695;95601;100033.49983250037;100515.49742251242;948.0756262643868;1002.7443002034435;1006.9295149339476;1061.4321338084087;1061.5594528270835;17145.142742862557;17228.760261165968;17338.13309334503;17388.65222695514;17642.38251661237;35491.29017419689;37202.27977202258;39144.217115658095;39499.21001579895;41634.79182604067;50386.74806625943;52739.73630131825;53042.73478632582;53275.733621331645;53285.7335713319;7796.415268854972;8047.034355877332;8645.092265312052;8893.64425422976;8939.150780675825;13388.397522111334;13450.865491345352;13623.18260904349;13869;13901.791473128114;10976.945115274373;11043.889561104608;11121.110311175249;11363.090952723596;11396.088312935111;11527.308361498337;11667.59163429276;11684.18210725241;11760.000399965757;11867.228630139014;8128.715494957648;10942.085135101484;11291.435428228391;11399.430028498708;11443.370614616277;7595.430342724429;7950.085740139958;8024.478408903403;8300.667973281;8315.334773218006;8680.565971701515;10888.51001704941;11045.33727976324;11611.5355385787;11921.10591705643 17:27:52 INFO - PROCESS | 28032 | |3;mootools.html;1524.7179271834714;1555.292341984397;1743.1371471121788;1830.2495976649568;1831.8717689761722;7886.763397098096;8694.304455643549;8725.781855453617;9256.722298331053;9259.120383563559;8697.826043479126;8918.643254269822;8954.149355811187;8954.37319387643;8976.147266009719;2362.598358279088;2392.7726865947707;2396.7842894139526;2400.939976500584;2404.386881345263;2335.92992210234;2343.871087090209;2408.036785285882;2409.3976505873534;2411.4574220800355;2382.463945612241;2386.2125498585424;2396.760323967598;2401.795847352977;2402.267308470916;2303.193882141254;2319.8608083514873;2331.1374791327235;2335.801456876159;2338.497223097025;2327.6973993380752;2340.368100612842;2348.2016114520975;2353.376355265856;2359.2922123362923;8944.195022447946;8990.325725570543;9022.368434209608;9025;9027.548622568846;5348.117560602496;5426.75579598919;5437.945620543784;5439.347278326587;5537.667739935617;3582.444721068239;3584.9641503585153;3618.1135621772833;3679.521662183899;3733.1227161617;1063.1813503602261;1106.4080716816545;1107.058999850129;1145.7823013627385;1159.594142050284;12813.615591532362;12834;12855.22868627876;12884.484620615163;12902;4765;4822.228443449031;4855.635827312965;4901;4928.778204980713;10662.413567253876;10711.517981690842;10745.409002504937;10765.515551800188;10766.30019048775;5257.5005374489365;5468.4531546845;5539.473749993744;5543.279373681396;5597.720113994284;4396.714213576107;4954.133026720309;5067.3412456381175;5107.131787596118;5123.8719032023755;4084.9795751021647;4172.269852775813;4176.415301857743;4207;4299.817550173727;1281.5450515067016;1359.3135466589308;1364.0519838712;1374.0725010617793;1375.0580852116332;869.5565261716444;874.8643960186181;970.5583959298502;990.0742805476903;1008.5814387029301;5848.736806843703;5875.148103524965;5952.7023648817385;5959;6110.7861224856915;1030.7526193713454;1066.8826429092794;1080.713610893114;1089.9182561307935;1123.3540714089431;4070.104576993057;4147.3778933160265;4168.3955826405;4178.456800615901;4187.644050255702;11087.390193539271;11375.089992800557;11448.94275528617;11461.54153833854;11462.083033357478;10491.68524944253;11420.14348923834;11437.428128593538;11440.256383335223;11507.769844603228;8220.917790822135;8602.612882420306;8609.526476043753;8612.741617751477;8695.347848911231;5666.858328541654;5889.440503152194;5982.491488223375;6006.729697163725;6114.938850611437;10081.14310283634;10215.233857460571;10334;10335.22485813552;10493.52779124926;10414.062734353642;10490.842637360292;10576.206784491347;10594.099501542456;10683.626073087406;6760.661966901734;7312.41500679955;7545.170031296443;7786.18245084258;7880.684772609032;8568.35737319691;8569.271611912807;8593.742187734379;8610.397272190887;8646.43798153118;7052.471064670273;7346.52247603904;7421.2207718190975;7481.588512631857;7565.735199268;7176.246494118252;7254.347108760237;7310.853782924418;7323;7395.371393431618;6742.224644165984;6767.661616919233;6791.762288319885;6801.1158549388265;6811.148606424197;4900.289458028495;5026.170681837456;5031.295618613471;5160.458151893997;5219.712915789516;5223.242629818731;5267.73661316925;5292.655977361459;5320.973395133;5331.986922484715 17:27:52 INFO - PROCESS | 28032 | |4;prototype.html;336.26190511826553;347.7322461704488;349.7114880223815;352.4853713578176;353.41862635963855;5499.450054994499;5582.609217354787;5647.689377084259;5711.228984087147;5715.657060576368;5610.186522954169;5616.9327827712705;5637.520810731083;5638.661680299185;5653.462921022497;4376.6936314458;4382.649388048964;4390.341448782676;4410.580994805488;4428.180786554498;4105.322621767405;4365.5852693994175;4377.868663940071;4404.185225733234;4409.603135717784;4293.806778694966;4298.656107511407;4315.956840431602;4321.611055005049;4325.178216138924;4336.111097225062;4336.306191009423;4351.9782401088105;4354.629856462205;4369.541198174178;3768.7550309229814;3777.58446570877;3811.8284677189595;3842.346801043829;3846.9807650961566;5443.646162999432;5443.863903402446;5446.700431476267;5467.835964921059;5470.604995726104;4943.678660887031;4986.4514903360605;4987.62592805541;5016.097102521545;5034.496550344973;5578.609497335188;5834.212381328509;5836.241288632493;5860.97069514654;5861.3552509223955;4123.402106694512;4143.57046818847;4146.108586653853;4147.39862719907;4166.729147610008;6207.937920620781;6233.9999999999545;6242.968785156045;6244.0633904914175;6257;4151.584841515824;4309.245881970705;4319.028218650778;4334.371516130143;4341.869743907688;4335.566443355639;4335.913281734348;4339.1104823511105;4347.130573885235;4368.934465983013;4987.551120399182;4995.550400463976;4999.600031997432;5007.574356179693;5035.1188542005;5849.268841394825;5949.286085669661;5973.701314934236;6024.1566180734735;6025.78909738157;1480.0611199328914;1496.1247670113105;1507.5251295841774;1508.5926799764002;1509.6678730679232;933.3373304953424;934.9719508414759;966.8066386722684;968.6222373274429;987.7036888933435;5070.518300761421;5081.669691470042;5083.923741143886;5122.410922743932;5160.483951604884;5338.971190947415;5347.598930080259;5408.702521361284;5470.863228419322;5478.424765399655;4918.065567542156;5008.323876276656;5062;5072.0109578632555;5159.561437277798;2905.898293559715;2909.53068700305;2910.63617047869;2930.223490774946;2942.6757958918574;5557.138643510181;5560.221568980346;5572.777088916479;5602.523785478198;5610.803621873297;5322.2548843161985;5475.014497390508;5497.2958382901425;5514.8069817557;5549.223108764776;5506.843562851846;5530.778768849201;5573.777048918079;5586.190002449704;5596.656802367484;5148.124818780741;5356.384015838073;5376.220448034935;5378.220158076979;5409.891802164014;5264.552513036281;5289.814856480005;5296.629235953446;5297.894042119059;5339.7063161526485;5505.862353441196;5546.36216835053;5586.916196256978;5621.35354434229;6058.485028772604;4109.794510274414;4287.464066991626;4289.571042895685;4303.870883873489;4304.569543045671;5932.317783454785;6025.66858822769;6061.242344706911;6083.513318934563;6143.662098584621;5693.259876216065;5863.120531920246;5887.234659494238;5892.852678683067;5936.782959493207;5836.182934389274;5870.354261031198;5877.617954832922;5887.735051922588;5952.226210592596;5698;5772.797952071657;5791.681457519877;5813.883722325614;5818.4763371296785;5829.329627092939;5956.910646340221;5965.433283838029;5966.940330596812;5972.70136493165;5732.598718089694;5772.393898640582;5798.188253644577;5840.8247752567495;5863.560232982458 17:27:52 INFO - PROCESS | 28032 | |5;yui.html;661.7419206509462;678.8031470873447;732.3921145449277;738.1916801102794;745.9104907411112;11791;11967.880321196786;12374.319412432313;12429.129960902741;12441.377931103454;11898.821517677221;11904.642860714172;11907.821382679267;11955.7608847823;11957.521699132047;801.2868546993166;802.9156938521459;814.9022117345897;816.4366587054943;831.1812864328631;826.2728798657173;830.9501429914194;833.0752864320599;833.5873742497442;833.9749807505784;869.7347309070731;873.6112429968666;874.3704532736419;875.8773771671971;877.6840337478502;865.8614621660536;866.7356456280831;869.0180096490925;869.8390797702414;872.1365847810654;633.6673246545554;634.5653227539104;636.226984214182;637.91069250305;639.1052526462943;12917.160384574972;13035.608931732064;13044.41300141496;13091.279979601119;13120.868791312156;13557.389917453738;13608.931955340258;13685.521006764815;13692.794608080887;13808.1024733393;10426.218033647507;10430.530626121767;10512.579496820117;10555.683329500127;10572.52423640938;3671.4125739881756;3701.9444708329397;3707.480952666629;3753.493278407407;3766.8304926278383;52009.47990520084;52262.47737522614;52670.47329526694;53599.46400536023;53615.99999999961;10324.277300588887;10458.895411045944;10805.405702686428;10867.619633312795;11117.444127793578;16415.097169655546;16420;16468.917655411646;16597.668046639;16650.83349166517;7308.30571095745;7338.192798792129;7404.757290719491;7430.256974302527;7606.619669016527;4410.580994805488;4515.983903621659;4516.299973504047;4559;4682.41469816273;3223.7582181336493;3276.770626056201;3286.7370610351113;3287.8027318360973;3290.7860989035635;739.9112106547249;748.9737859174903;752.7139686918936;760.5056713136505;772.1120711182185;696.3767428151775;715.0918333716152;721.5418209437046;745.2770812312049;746.9663865125974;8384.16158384169;8809.986851512158;9111.954440227757;9241.399309044891;9302.813943721223;622.2129006806304;742.6954948471101;748.887666849966;758.3250906693048;766.7163149634559;4070.8575199867864;4307.138572285556;4330.090680957034;4399.6040356368085;4408.515063343029;57502.424975750546;59006.11490827641;59014.40985590175;60293;61540.38459615347;53239.733801330745;55023;55059.72470137624;55072.44927550753;56934;48953.5104648949;49370.50629493731;50322.24516632254;50520;51062.48937510652;7776.144624091232;7978;7979.082405523207;8055.516668999644;8131.918680813116;32270.35459290848;32659.836700816344;32963.505547417284;33218.16954576155;33622.66377336293;42876.35685464783;42965.14069718651;43336;43808.56191438045;44152.896177595816;10932.945335273273;11241.831372529256;11253.268537545033;11263.211575189658;11326.886731132583;12021.459034343301;12256.693582660504;12508.499660013498;12660.810087848506;12817.295048772407;11303.321800691985;11349.092072634005;11352.659420217407;11509.136814739095;11522.135839812216;11823.290602563873;11947.402629868646;11950.223235489666;11996.940015299868;12140.817887731515;10868.293560918515;11099.889001109885;11151.776964460827;11287.830682539605;11451.713707157387;9119;9544.761380965532;9611.375260608038;9812.509374531388;9853.06395892389;9289.6284148636;9547.236221102434;9686.854697179408;9847.901520984986;10013.59945602197 17:27:52 INFO - PROCESS | 28032 | __end_tp_report 17:27:52 INFO - PROCESS | 28032 | __start_cc_report 17:27:52 INFO - PROCESS | 28032 | _x_x_mozilla_cycle_collect,347 17:27:52 INFO - PROCESS | 28032 | __end_cc_report 17:27:52 INFO - PROCESS | 28032 | __startTimestamp1462926472807__endTimestamp 17:27:52 INFO - PROCESS | 28032 | 17:27:52 INFO - PROCESS | 28032 | ------- Summary: start ------- 17:27:52 INFO - PROCESS | 28032 | Number of tests: 6 17:27:52 INFO - PROCESS | 28032 | 17:27:52 INFO - PROCESS | 28032 | [#0] dojo.html Cycles:165 Average:5500.28 Median:5701.54 stddev:646.72 (11.3%) stddev-sans-first:621.46 17:27:52 INFO - PROCESS | 28032 | Values: 3132.6 3140.2 3147.8 3178.3 3201.0 5353.7 5383.5 5385.4 5487.9 5544.3 5419.5 5531.6 5534.1 5577.4 5588.9 4923.6 5033.7 5076.2 5094.0 5105.6 4967.5 5185.8 5186.5 5196.5 5213.8 4953.0 4980.8 4987.7 5004.3 5058.2 5071.8 5072.6 5075.0 5083.8 5148.4 4983.5 5015.2 5026.2 5027.0 5051.5 5389.0 5397.5 5411.2 5420.4 5488.7 5926.0 5933.1 5949.4 5966.3 5984.8 5724.7 5783.7 5951.2 5956.9 5978.9 5505.0 5505.4 5554.6 5582.9 5622.7 6044.0 6079.4 6140.1 6143.8 6144.1 5709.8 5741.5 5875.7 5881.6 5883.6 5836.2 5886.1 5893.9 5899.7 5949.9 5784.9 5844.5 5845.7 5866.8 5882.9 5689.7 5894.1 5979.9 5986.0 5989.2 4429.0 4447.2 4465.0 4487.8 4492.0 3999.7 4004.6 4010.0 4031.8 4044.1 5558.8 5633.2 5636.2 5647.7 5651.1 5996.6 6097.2 6102.5 6103.9 6106.7 5673.5 5729.0 5743.6 5758.6 5796.9 4763.2 4892.0 4903.1 4974.8 4992.8 6233.8 6237.4 6247.6 6247.8 6258.1 5925.3 5980.9 6022.2 6024.0 6101.1 5917.4 6075.7 6098.6 6119.7 6216.6 5781.3 5821.8 5847.5 5852.6 5862.8 5927.4 5971.6 5981.2 5998.4 5999.0 5563.7 5598.4 5746.6 5754.7 5782.7 5603.0 5667.4 5674.1 5701.5 5722.4 5587.4 5591.5 5609.6 5662.1 5676.8 5716.1 5825.4 5909.6 5962.2 5962.3 5815.2 5860.5 5861.8 5863.9 5871.2 17:27:52 INFO - PROCESS | 28032 | 17:27:52 INFO - PROCESS | 28032 | [#1] ext.html Cycles:180 Average:54584.58 Median:390956.00 stddev:105940.80 (27.1%) stddev-sans-first:106160.45 17:27:52 INFO - PROCESS | 28032 | Values: 598.4 636.2 641.3 658.6 681.3 41325.0 42269.8 42297.2 42303.8 42351.0 42912.6 43663.8 43727.6 43830.3 43885.0 8858.4 8992.2 9015.1 9019.2 9040.5 8792.4 8813.3 8834.6 8842.6 8873.7 8858.0 8904.0 8904.6 8923.1 8955.7 8740.4 8831.2 8832.7 8834.6 8864.0 8735.5 8819.0 8856.1 8857.5 8887.2 34491.5 39764.4 40225.6 40234.0 40258.4 3165.1 3226.0 3391.4 3464.3 3498.3 30698.0 31076.4 31205.5 31511.0 31709.0 4059.4 4085.9 4141.0 4143.3 4223.2 287448.0 288317.0 288680.0 289777.0 290093.0 34146.3 35278.0 36586.0 36845.3 36953.3 36601.8 36788.0 36897.4 36909.6 36993.8 16117.5 16147.4 16167.7 16170.5 16195.2 13419.7 13433.6 13437.5 13437.9 13548.3 8702.9 8705.3 8729.5 8751.0 8763.9 3327.2 3335.6 3357.3 3397.4 3439.2 1027.4 1075.3 1118.5 1155.5 1165.7 32187.5 32360.5 32947.0 33048.5 33058.5 1136.7 1163.6 1234.1 1243.4 1250.5 17388.1 17480.8 17559.2 17595.4 17688.7 489823.0 492532.0 496453.0 497363.0 500071.0 59029.7 59220.4 59518.7 59567.0 59604.0 1372.8 1384.9 1394.6 1396.5 1406.9 30997.5 31365.7 31649.5 31801.8 32780.2 52080.5 52884.7 52947.0 52967.7 53039.2 382228.0 388312.0 390205.0 390857.0 391055.0 29043.7 29336.0 29373.9 29507.4 29522.7 48530.5 50006.0 50108.0 51188.5 51775.6 41349.6 41400.4 41844.0 41858.4 43027.8 41842.2 41893.8 42087.6 42303.4 42913.4 37387.0 41738.8 42156.8 42624.6 42904.8 35737.8 36669.0 36722.7 37077.1 38225.8 28497.6 28804.3 29439.7 29464.0 31530.4 17:27:52 INFO - PROCESS | 28032 | 17:27:52 INFO - PROCESS | 28032 | [#2] jquery.html Cycles:180 Average:28142.57 Median:12441.04 stddev:76440.58 (614.4%) stddev-sans-first:76626.66 17:27:52 INFO - PROCESS | 28032 | Values: 410.3 411.3 419.7 421.5 424.4 19229.4 19396.1 19656.7 19794.1 20369.7 18748.4 19102.9 19282.0 19324.0 19437.9 5496.2 5826.2 5831.5 5850.1 5861.2 5514.8 5696.3 5801.7 5807.9 5819.3 5727.3 5730.3 5737.0 5775.9 5776.7 5474.2 5633.1 5706.3 5739.6 5739.8 5109.3 5117.9 5130.9 5143.9 5153.3 22222.8 22366.0 22608.9 22849.0 22910.0 2273.2 2399.8 2454.7 2499.6 2643.0 14105.0 14746.0 14908.0 14932.8 15203.9 1778.9 1826.8 1835.5 1841.4 1872.9 72760.6 75117.6 76253.2 80214.8 81931.2 10944.8 11194.4 11505.2 11556.5 11670.1 15996.8 16074.4 16173.4 16194.0 16243.2 8367.6 8460.5 8503.8 8580.0 8592.8 8086.5 8212.0 8290.7 8315.2 8371.1 4863.1 4908.0 4949.8 4957.7 5003.7 1998.8 2007.8 2069.0 2091.7 2092.3 925.9 1018.6 1041.1 1116.1 1135.0 17308.7 19536.9 19609.5 19610.8 19807.4 1034.6 1035.8 1046.9 1095.5 1098.6 10624.7 10821.9 11026.8 11103.8 11156.2 453919.0 455435.0 465722.0 466581.0 472768.0 92606.5 93840.5 95601.0 100033.5 100515.5 948.1 1002.7 1006.9 1061.4 1061.6 17145.1 17228.8 17338.1 17388.7 17642.4 35491.3 37202.3 39144.2 39499.2 41634.8 50386.7 52739.7 53042.7 53275.7 53285.7 7796.4 8047.0 8645.1 8893.6 8939.2 13388.4 13450.9 13623.2 13869.0 13901.8 10976.9 11043.9 11121.1 11363.1 11396.1 11527.3 11667.6 11684.2 11760.0 11867.2 8128.7 10942.1 11291.4 11399.4 11443.4 7595.4 7950.1 8024.5 8300.7 8315.3 8680.6 10888.5 11045.3 11611.5 11921.1 17:27:52 INFO - PROCESS | 28032 | 17:27:52 INFO - PROCESS | 28032 | [#3] mootools.html Cycles:180 Average:5908.83 Median:4348.27 stddev:3370.21 (77.5%) stddev-sans-first:3363.56 17:27:52 INFO - PROCESS | 28032 | Values: 1524.7 1555.3 1743.1 1830.2 1831.9 7886.8 8694.3 8725.8 9256.7 9259.1 8697.8 8918.6 8954.1 8954.4 8976.1 2362.6 2392.8 2396.8 2400.9 2404.4 2335.9 2343.9 2408.0 2409.4 2411.5 2382.5 2386.2 2396.8 2401.8 2402.3 2303.2 2319.9 2331.1 2335.8 2338.5 2327.7 2340.4 2348.2 2353.4 2359.3 8944.2 8990.3 9022.4 9025.0 9027.5 5348.1 5426.8 5437.9 5439.3 5537.7 3582.4 3585.0 3618.1 3679.5 3733.1 1063.2 1106.4 1107.1 1145.8 1159.6 12813.6 12834.0 12855.2 12884.5 12902.0 4765.0 4822.2 4855.6 4901.0 4928.8 10662.4 10711.5 10745.4 10765.5 10766.3 5257.5 5468.5 5539.5 5543.3 5597.7 4396.7 4954.1 5067.3 5107.1 5123.9 4085.0 4172.3 4176.4 4207.0 4299.8 1281.5 1359.3 1364.1 1374.1 1375.1 869.6 874.9 970.6 990.1 1008.6 5848.7 5875.1 5952.7 5959.0 6110.8 1030.8 1066.9 1080.7 1089.9 1123.4 4070.1 4147.4 4168.4 4178.5 4187.6 11087.4 11375.1 11448.9 11461.5 11462.1 10491.7 11420.1 11437.4 11440.3 11507.8 8220.9 8602.6 8609.5 8612.7 8695.3 5666.9 5889.4 5982.5 6006.7 6114.9 10081.1 10215.2 10334.0 10335.2 10493.5 10414.1 10490.8 10576.2 10594.1 10683.6 6760.7 7312.4 7545.2 7786.2 7880.7 8568.4 8569.3 8593.7 8610.4 8646.4 7052.5 7346.5 7421.2 7481.6 7565.7 7176.2 7254.3 7310.9 7323.0 7395.4 6742.2 6767.7 6791.8 6801.1 6811.1 4900.3 5026.2 5031.3 5160.5 5219.7 5223.2 5267.7 5292.7 5321.0 5332.0 17:27:52 INFO - PROCESS | 28032 | 17:27:52 INFO - PROCESS | 28032 | [#4] prototype.html Cycles:180 Average:4790.29 Median:5377.22 stddev:1388.04 (25.8%) stddev-sans-first:1351.08 17:27:52 INFO - PROCESS | 28032 | Values: 336.3 347.7 349.7 352.5 353.4 5499.5 5582.6 5647.7 5711.2 5715.7 5610.2 5616.9 5637.5 5638.7 5653.5 4376.7 4382.6 4390.3 4410.6 4428.2 4105.3 4365.6 4377.9 4404.2 4409.6 4293.8 4298.7 4316.0 4321.6 4325.2 4336.1 4336.3 4352.0 4354.6 4369.5 3768.8 3777.6 3811.8 3842.3 3847.0 5443.6 5443.9 5446.7 5467.8 5470.6 4943.7 4986.5 4987.6 5016.1 5034.5 5578.6 5834.2 5836.2 5861.0 5861.4 4123.4 4143.6 4146.1 4147.4 4166.7 6207.9 6234.0 6243.0 6244.1 6257.0 4151.6 4309.2 4319.0 4334.4 4341.9 4335.6 4335.9 4339.1 4347.1 4368.9 4987.6 4995.6 4999.6 5007.6 5035.1 5849.3 5949.3 5973.7 6024.2 6025.8 1480.1 1496.1 1507.5 1508.6 1509.7 933.3 935.0 966.8 968.6 987.7 5070.5 5081.7 5083.9 5122.4 5160.5 5339.0 5347.6 5408.7 5470.9 5478.4 4918.1 5008.3 5062.0 5072.0 5159.6 2905.9 2909.5 2910.6 2930.2 2942.7 5557.1 5560.2 5572.8 5602.5 5610.8 5322.3 5475.0 5497.3 5514.8 5549.2 5506.8 5530.8 5573.8 5586.2 5596.7 5148.1 5356.4 5376.2 5378.2 5409.9 5264.6 5289.8 5296.6 5297.9 5339.7 5505.9 5546.4 5586.9 5621.4 6058.5 4109.8 4287.5 4289.6 4303.9 4304.6 5932.3 6025.7 6061.2 6083.5 6143.7 5693.3 5863.1 5887.2 5892.9 5936.8 5836.2 5870.4 5877.6 5887.7 5952.2 5698.0 5772.8 5791.7 5813.9 5818.5 5829.3 5956.9 5965.4 5966.9 5972.7 5732.6 5772.4 5798.2 5840.8 5863.6 17:27:52 INFO - PROCESS | 28032 | 17:27:52 INFO - PROCESS | 28032 | [#5] yui.html Cycles:180 Average:14082.59 Median:26817.96 stddev:16696.90 (62.3%) stddev-sans-first:16713.32 17:27:52 INFO - PROCESS | 28032 | Values: 661.7 678.8 732.4 738.2 745.9 11791.0 11967.9 12374.3 12429.1 12441.4 11898.8 11904.6 11907.8 11955.8 11957.5 801.3 802.9 814.9 816.4 831.2 826.3 831.0 833.1 833.6 834.0 869.7 873.6 874.4 875.9 877.7 865.9 866.7 869.0 869.8 872.1 633.7 634.6 636.2 637.9 639.1 12917.2 13035.6 13044.4 13091.3 13120.9 13557.4 13608.9 13685.5 13692.8 13808.1 10426.2 10430.5 10512.6 10555.7 10572.5 3671.4 3701.9 3707.5 3753.5 3766.8 52009.5 52262.5 52670.5 53599.5 53616.0 10324.3 10458.9 10805.4 10867.6 11117.4 16415.1 16420.0 16468.9 16597.7 16650.8 7308.3 7338.2 7404.8 7430.3 7606.6 4410.6 4516.0 4516.3 4559.0 4682.4 3223.8 3276.8 3286.7 3287.8 3290.8 739.9 749.0 752.7 760.5 772.1 696.4 715.1 721.5 745.3 747.0 8384.2 8810.0 9112.0 9241.4 9302.8 622.2 742.7 748.9 758.3 766.7 4070.9 4307.1 4330.1 4399.6 4408.5 57502.4 59006.1 59014.4 60293.0 61540.4 53239.7 55023.0 55059.7 55072.4 56934.0 48953.5 49370.5 50322.2 50520.0 51062.5 7776.1 7978.0 7979.1 8055.5 8131.9 32270.4 32659.8 32963.5 33218.2 33622.7 42876.4 42965.1 43336.0 43808.6 44152.9 10932.9 11241.8 11253.3 11263.2 11326.9 12021.5 12256.7 12508.5 12660.8 12817.3 11303.3 11349.1 11352.7 11509.1 11522.1 11823.3 11947.4 11950.2 11996.9 12140.8 10868.3 11099.9 11151.8 11287.8 11451.7 9119.0 9544.8 9611.4 9812.5 9853.1 9289.6 9547.2 9686.9 9847.9 10013.6 17:27:52 INFO - PROCESS | 28032 | -------- Summary: end -------- 17:27:52 INFO - PROCESS | 28032 | 17:27:53 INFO - TEST-INFO | 28032: exit 0 17:27:53 INFO - TEST-OK | dromaeo_css | took 1110518ms 17:27:53 INFO - TEST-START | kraken 17:27:53 INFO - operating with platform_type : linux_ 17:27:53 INFO - Initialising browser for kraken test... 17:27:53 INFO - TEST-INFO | started process 28269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPX1VPj/profile http://localhost:34368/getInfo.html) 17:27:57 INFO - PROCESS | 28269 | 17:27:57 INFO - PROCESS | 28269 | (process:28336): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:27:58 INFO - PROCESS | 28269 | __metrics Screen width/height:1600/1200 17:27:58 INFO - PROCESS | 28269 | colorDepth:24 17:27:58 INFO - PROCESS | 28269 | Browser inner width/height: 1024/697 17:27:58 INFO - PROCESS | 28269 | __metrics 17:27:58 ERROR - PROCESS | 28269 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:27:59 INFO - TEST-INFO | 28269: exit 0 17:27:59 INFO - Browser initialized. 17:27:59 INFO - Running cycle 1/1 for kraken test... 17:27:59 INFO - TEST-INFO | started process 28387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPX1VPj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:01 INFO - PROCESS | 28387 | 17:28:01 INFO - PROCESS | 28387 | (process:28447): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:28:11 INFO - PROCESS | 28387 | RSS: Main: 163475456 17:28:11 INFO - PROCESS | 28387 | 17:28:14 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34368/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:14 INFO - PROCESS | 28387 | RSS: Main: 167751680 17:28:14 INFO - PROCESS | 28387 | 17:28:17 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34368/tests/kraken/driver.html?testName=audio-dft) 17:28:18 INFO - PROCESS | 28387 | RSS: Main: 167739392 17:28:18 INFO - PROCESS | 28387 | 17:28:21 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34368/tests/kraken/driver.html?testName=audio-fft) 17:28:21 INFO - PROCESS | 28387 | RSS: Main: 162619392 17:28:21 INFO - PROCESS | 28387 | 17:28:24 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34368/tests/kraken/driver.html?testName=audio-oscillator) 17:28:24 INFO - PROCESS | 28387 | RSS: Main: 164024320 17:28:24 INFO - PROCESS | 28387 | 17:28:27 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34368/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:27 INFO - PROCESS | 28387 | RSS: Main: 163676160 17:28:27 INFO - PROCESS | 28387 | 17:28:30 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34368/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:31 INFO - PROCESS | 28387 | RSS: Main: 163667968 17:28:31 INFO - PROCESS | 28387 | 17:28:34 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34368/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:35 INFO - PROCESS | 28387 | RSS: Main: 162553856 17:28:35 INFO - PROCESS | 28387 | 17:28:38 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34368/tests/kraken/driver.html?testName=json-parse-financial) 17:28:39 INFO - PROCESS | 28387 | RSS: Main: 163074048 17:28:39 INFO - PROCESS | 28387 | 17:28:40 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34368/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:41 INFO - PROCESS | 28387 | RSS: Main: 163414016 17:28:41 INFO - PROCESS | 28387 | 17:28:43 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:43 INFO - PROCESS | 28387 | RSS: Main: 163733504 17:28:43 INFO - PROCESS | 28387 | 17:28:45 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:46 INFO - PROCESS | 28387 | RSS: Main: 164044800 17:28:46 INFO - PROCESS | 28387 | 17:28:49 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:50 INFO - PROCESS | 28387 | RSS: Main: 164061184 17:28:50 INFO - PROCESS | 28387 | 17:28:52 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:53 INFO - PROCESS | 28387 | RSS: Main: 163975168 17:28:53 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34368/tests/kraken/driver.html?testName=ai-astar) 17:28:55 INFO - PROCESS | 28387 | RSS: Main: 165404672 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | __start_tp_report 17:28:55 INFO - PROCESS | 28387 | _x_x_mozilla_page_load 17:28:55 INFO - PROCESS | 28387 | _x_x_mozilla_page_load_details 17:28:55 INFO - PROCESS | 28387 | |i|pagename|runs| 17:28:55 INFO - PROCESS | 28387 | |0;ai-astar;109;115;105;111;111;112;105;112;112;113 17:28:55 INFO - PROCESS | 28387 | |1;audio-beat-detection;150;134;151;219;127;166;159;135;191;127 17:28:55 INFO - PROCESS | 28387 | |2;audio-dft;162;162;162;162;163;174;163;164;164;163 17:28:55 INFO - PROCESS | 28387 | |3;audio-fft;81;76;76;172;76;76;75;77;165;76 17:28:55 INFO - PROCESS | 28387 | |4;audio-oscillator;92;93;181;92;93;94;144;93;92;159 17:28:55 INFO - PROCESS | 28387 | |5;imaging-gaussian-blur;117;118;118;117;117;117;118;117;118;118 17:28:55 INFO - PROCESS | 28387 | |6;imaging-darkroom;147;148;149;146;148;147;147;147;147;147 17:28:55 INFO - PROCESS | 28387 | |7;imaging-desaturate;95;96;96;96;95;95;95;95;95;96 17:28:55 INFO - PROCESS | 28387 | |8;json-parse-financial;59;61;60;58;62;58;63;113;56;56 17:28:55 INFO - PROCESS | 28387 | |9;json-stringify-tinderbox;60;59;59;59;59;58;59;59;59;59 17:28:55 INFO - PROCESS | 28387 | |10;stanford-crypto-aes;83;81;80;88;80;78;80;81;82;82 17:28:55 INFO - PROCESS | 28387 | |11;stanford-crypto-ccm;134;126;127;137;126;141;123;139;191;133 17:28:55 INFO - PROCESS | 28387 | |12;stanford-crypto-pbkdf2;169;170;171;173;172;171;181;171;167;174 17:28:55 INFO - PROCESS | 28387 | |13;stanford-crypto-sha256-iterative;70;70;67;70;69;68;67;65;65;64 17:28:55 INFO - PROCESS | 28387 | __end_tp_report 17:28:55 INFO - PROCESS | 28387 | __start_cc_report 17:28:55 INFO - PROCESS | 28387 | _x_x_mozilla_cycle_collect,849 17:28:55 INFO - PROCESS | 28387 | __end_cc_report 17:28:55 INFO - PROCESS | 28387 | __startTimestamp1462926535496__endTimestamp 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | ------- Summary: start ------- 17:28:55 INFO - PROCESS | 28387 | Number of tests: 14 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.27 (2.9%) stddev-sans-first:3.43 17:28:55 INFO - PROCESS | 28387 | Values: 109.0 115.0 105.0 111.0 111.0 112.0 105.0 112.0 112.0 113.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:155.00 stddev:29.76 (19.2%) stddev-sans-first:31.49 17:28:55 INFO - PROCESS | 28387 | Values: 150.0 134.0 151.0 219.0 127.0 166.0 159.0 135.0 191.0 127.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.63 (2.2%) stddev-sans-first:3.79 17:28:55 INFO - PROCESS | 28387 | Values: 162.0 162.0 162.0 162.0 163.0 174.0 163.0 164.0 164.0 163.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:38.81 (51.1%) stddev-sans-first:40.83 17:28:55 INFO - PROCESS | 28387 | Values: 81.0 76.0 76.0 172.0 76.0 76.0 75.0 77.0 165.0 76.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#4] audio-oscillator Cycles:10 Average:113.30 Median:92.50 stddev:34.29 (37.1%) stddev-sans-first:35.50 17:28:55 INFO - PROCESS | 28387 | Values: 92.0 93.0 181.0 92.0 93.0 94.0 144.0 93.0 92.0 159.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:28:55 INFO - PROCESS | 28387 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 17:28:55 INFO - PROCESS | 28387 | Values: 147.0 148.0 149.0 146.0 148.0 147.0 147.0 147.0 147.0 147.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:28:55 INFO - PROCESS | 28387 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:59.50 stddev:17.17 (28.9%) stddev-sans-first:18.09 17:28:55 INFO - PROCESS | 28387 | Values: 59.0 61.0 60.0 58.0 62.0 58.0 63.0 113.0 56.0 56.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 17:28:55 INFO - PROCESS | 28387 | Values: 60.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 59.0 59.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:2.68 (3.3%) stddev-sans-first:2.78 17:28:55 INFO - PROCESS | 28387 | Values: 83.0 81.0 80.0 88.0 80.0 78.0 80.0 81.0 82.0 82.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:135.50 stddev:19.70 (14.5%) stddev-sans-first:20.85 17:28:55 INFO - PROCESS | 28387 | Values: 134.0 126.0 127.0 137.0 126.0 141.0 123.0 139.0 191.0 133.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:171.50 stddev:3.75 (2.2%) stddev-sans-first:3.83 17:28:55 INFO - PROCESS | 28387 | Values: 169.0 170.0 171.0 173.0 172.0 171.0 181.0 171.0 167.0 174.0 17:28:55 INFO - PROCESS | 28387 | 17:28:55 INFO - PROCESS | 28387 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.50 stddev:2.27 (3.3%) stddev-sans-first:2.22 17:28:55 INFO - PROCESS | 28387 | Values: 70.0 70.0 67.0 70.0 69.0 68.0 67.0 65.0 65.0 64.0 17:28:55 INFO - PROCESS | 28387 | -------- Summary: end -------- 17:28:55 INFO - PROCESS | 28387 | 17:28:56 INFO - TEST-INFO | 28387: exit 0 17:28:56 INFO - TEST-OK | kraken | took 62926ms 17:28:56 INFO - SUITE-END | took 1173s 17:28:56 INFO - Completed test suite (00:19:33) 17:28:56 INFO - javascript benchmark 17:28:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.5927629408175, 3140.1678555182866, 3147.795393299437, 3178.300773829758, 3200.951985720213, 5353.705546194958, 5383.46165383461, 5385.380681221661, 5487.890242195153, 5544.251526043983, 5419.458054194579, 5531.557475401958, 5534.059209934311, 5577.414371490986, 5588.888222235553, 4923.6307276954285, 5033.672811267256, 5076.23856421536, 5094.006668699605, 5105.617078719092, 4967.478414766451, 5185.818496352628, 5186.507281808241, 5196.480351964811, 5213.843584692465, 4952.975235123801, 4980.800767969295, 4987.650864439491, 5004.349434573519, 5058.165402708549, 5071.771770270347, 5072.568831649314, 5075.0, 5083.847484575432, 5148.4079330876675, 4983.451820299764, 5015.1975683890405, 5026.220935754964, 5026.974865125688, 5051.545360917498, 5388.973055134699, 5397.460253974571, 5411.161270003156, 5420.430854760233, 5488.725563721838, 5925.970370148165, 5933.110033494967, 5949.405059494059, 5966.3138739045135, 5984.790532331347, 5724.713764311768, 5783.739731712083, 5951.196588460546, 5956.880862382772, 5978.8505287367725, 5505.0, 5505.366882808488, 5554.638948468337, 5582.86042848932, 5622.746976386073, 6043.969780151071, 6079.3920607939735, 6140.140380346755, 6143.784967526115, 6144.139820425144, 5709.800156994485, 5741.540676745851, 5875.735591898289, 5881.558883083786, 5883.558733095035, 5836.241288632451, 5886.117082437669, 5893.911591326134, 5899.734511946973, 5949.940500594938, 5784.913226301609, 5844.532437404998, 5845.7369418376275, 5866.794662186889, 5882.911756323659, 5689.687067211343, 5894.115882617556, 5979.850503737442, 5986.0, 5989.161517387569, 4429.0, 4447.199504089295, 4465.0400163964905, 4487.798049087799, 4492.0, 3999.7200195986, 4004.5795191505053, 4009.959900401017, 4031.7580945143386, 4044.1102957349926, 5558.805441809598, 5633.211350410946, 5636.18275350072, 5647.661140331511, 5651.095824668033, 5996.580239383288, 6097.185685213644, 6102.51954821894, 6103.943827031755, 6106.695694098542, 5673.517750991212, 5729.0260655688635, 5743.569232307594, 5758.62568933018, 5796.913046304308, 4763.190257656207, 4892.046051020088, 4903.068417000758, 4974.77613507393, 4992.775325110306, 6233.812985610439, 6237.438630523275, 6247.625142491465, 6247.812565623039, 6258.123862659231, 5925.288965324189, 5980.850478738066, 6022.223444083918, 6024.0, 6101.054336577838, 5917.437843404869, 6075.665838378932, 6098.583513185022, 6119.724612392542, 6216.595921265103, 5781.306243250837, 5821.76712931495, 5847.473727364558, 5852.619579727304, 5862.824115276549, 5927.436893495111, 5971.611845230046, 5981.222441082631, 5998.370171132143, 5998.970005149947, 5563.749631266522, 5598.384177740527, 5746.569007324551, 5754.683492407958, 5782.739776709974, 5602.9719851402115, 5667.40492248308, 5674.120511320752, 5701.543876489954, 5722.370539240597, 5587.385387607279, 5591.496765291144, 5609.579281553818, 5662.094064949753, 5676.77292908279, 5716.056850619601, 5825.446582574648, 5909.556783241188, 5962.165296858357, 5962.314333851489, 5815.2149459822385, 5860.501857342174, 5861.824145275648, 5863.853403664943, 5871.236739223874], "value": 5455.134553062818, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.3597550620838, 636.2238069555141, 641.3490307338052, 658.6245839871273, 681.3493114076058, 41325.0, 42269.78865105674, 42297.15405691892, 42303.78848105755, 42351.0, 42912.57087429125, 43663.78168109163, 43727.56272437274, 43830.34254486185, 43885.0, 8858.424202426853, 8992.23565996891, 9015.098490150966, 9019.233365163936, 9040.547972601376, 8792.384533082686, 8813.250873675714, 8834.646614135427, 8842.557872106401, 8873.73378798637, 8858.0, 8904.020557738644, 8904.643814247454, 8923.063078376774, 8955.731328060136, 8740.388172827905, 8831.161039701217, 8832.735017949472, 8834.602442890086, 8864.024957254696, 8735.519546424945, 8818.955905220497, 8856.070112638145, 8857.512836793974, 8887.200151986288, 34491.482627760604, 39764.403533947014, 40225.59774402277, 40234.0, 40258.39612405816, 3165.1454107391105, 3225.951610725841, 3391.3895498810202, 3464.3071385722956, 3498.3353162898966, 30698.0, 31076.369811697627, 31205.531917021035, 31511.0, 31709.0, 4059.3505039193587, 4085.9387109193385, 4140.979295103535, 4143.268556421558, 4223.176480586287, 287448.0, 288317.0, 288679.9999999979, 289777.0, 290093.0, 34146.317073658385, 35278.0, 36586.0, 36845.26309473849, 36953.26093478115, 36601.81699091541, 36788.0, 36897.44653830195, 36909.630903691155, 36993.81503092467, 16117.516474505783, 16147.434839780552, 16167.67664646724, 16170.514884553248, 16195.190240488164, 13419.725126113004, 13433.596992090253, 13437.462501499831, 13437.924966002696, 13548.254845983565, 8702.912970870337, 8705.260052895448, 8729.476231426135, 8750.956245218733, 8763.912360876437, 3327.168207948013, 3335.5997280326515, 3357.3285342931513, 3397.371486275047, 3439.1574064354395, 1027.3527677563088, 1075.2795626929976, 1118.5413980268052, 1155.526234243956, 1165.6561314412268, 32187.51718724221, 32360.514592281135, 32947.0, 33048.50427243593, 33058.504122438186, 1136.687410961992, 1163.6334554615269, 1234.1052736765773, 1243.3969524780475, 1250.4998000799571, 17388.130593470276, 17480.825191748176, 17559.20983555743, 17595.384161554284, 17688.734668979974, 489823.0, 492532.0, 496453.0, 497363.0, 500071.0, 59029.70485147633, 59220.40779592235, 59518.70240648769, 59567.0, 59604.0, 1372.7597670407638, 1384.9099808512415, 1394.5676840179576, 1396.5182012205773, 1406.866347696967, 30997.53503697401, 31365.686343136276, 31649.525257121622, 31801.8409907949, 32780.1804954878, 52080.47919520908, 52884.73557632187, 52947.0, 52967.735161323944, 53039.204411934625, 382228.0, 388312.0, 390205.0, 390857.0, 391055.0, 29043.709562904947, 29336.0, 29373.85313073421, 29507.409851802415, 29522.704772951995, 48530.51469485401, 50006.0, 50108.0, 51188.488115119864, 51775.599074079124, 41349.586504134575, 41400.37899431451, 41844.0, 41858.37212441877, 43027.784861075495, 41842.163156737304, 41893.79053104715, 42087.579124208365, 42303.3654495189, 42913.35629965615, 37387.0, 41738.79130604328, 42156.78921605495, 42624.57375426206, 42904.78547607242, 35737.821310893276, 36669.0, 36722.7147049852, 37077.07307317231, 38225.808870955465, 28497.572536411557, 28804.279893002844, 29439.705602943697, 29464.0, 31530.36939261248], "value": 18730.319089867975, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.28405432520276, 411.2741012113618, 419.7439561867262, 421.515257453928, 424.39735575482814, 19229.423117306487, 19396.1118163941, 19656.739474960366, 19794.10926508307, 20369.694454583194, 18748.43754687358, 19102.90448547759, 19282.0, 19324.0, 19437.902810485964, 5496.1755736639525, 5826.242588463515, 5831.4751672349485, 5850.0932355484965, 5861.2087368205175, 5514.834554963358, 5696.287964004499, 5801.738921748511, 5807.854803629922, 5819.30168379795, 5727.284089488814, 5730.283714535683, 5737.0, 5775.855603609902, 5776.682282474462, 5474.233607294982, 5633.126865335838, 5706.315242170946, 5739.569532285095, 5739.770409183628, 5109.310243117169, 5117.923231151536, 5130.871728206825, 5143.948560514385, 5153.330067091291, 22222.77777222223, 22366.0, 22608.886955565118, 22849.0, 22910.0, 2273.1930164791593, 2399.796017338528, 2454.680891484096, 2499.5875680512877, 2643.035292118363, 14105.0, 14746.0, 14908.0, 14932.776008359884, 15203.859710521756, 1778.8754787164903, 1826.8355847973746, 1835.4952388093247, 1841.4015444980434, 1872.8595355348268, 72760.6361968192, 75117.6244118776, 76253.23746762516, 80214.79677804837, 81931.18068819295, 10944.781104377867, 11194.440277986068, 11505.194636375374, 11556.479958401893, 11670.124740644485, 15996.840031599768, 16074.357025719075, 16173.4339298124, 16194.0, 16243.187840607923, 8367.58162091905, 8460.450070745383, 8503.787405314793, 8579.957100214458, 8592.785180370542, 8086.474379165335, 8212.0, 8290.668373265002, 8315.168483151636, 8371.121032291643, 4863.1003264395495, 4908.0, 4949.752512374367, 4957.677750946177, 5003.72479513623, 1998.8300994415347, 2007.7574716832503, 2068.979310206879, 2091.7280753501946, 2092.3199960012753, 925.9259259259378, 1018.5772904244656, 1041.1358572384902, 1116.0625074937093, 1134.9886501135047, 17308.65382692339, 19536.902315488616, 19609.509762255773, 19610.8038919609, 19807.405777826687, 1034.5706531789374, 1035.7773078787945, 1046.9214808889365, 1095.46322302073, 1098.5770478365887, 10624.681259562225, 10821.891781082246, 11026.779464410667, 11103.83344249837, 11156.219064665396, 453919.0, 455435.0, 465722.0, 466581.0, 472768.0, 92606.53696731474, 93840.53079734695, 95601.0, 100033.49983250037, 100515.49742251242, 948.0756262643868, 1002.7443002034435, 1006.9295149339476, 1061.4321338084087, 1061.5594528270835, 17145.142742862557, 17228.760261165968, 17338.13309334503, 17388.65222695514, 17642.38251661237, 35491.29017419689, 37202.27977202258, 39144.217115658095, 39499.21001579895, 41634.79182604067, 50386.74806625943, 52739.73630131825, 53042.73478632582, 53275.733621331645, 53285.7335713319, 7796.415268854972, 8047.034355877332, 8645.092265312052, 8893.64425422976, 8939.150780675825, 13388.397522111334, 13450.865491345352, 13623.18260904349, 13869.0, 13901.791473128114, 10976.945115274373, 11043.889561104608, 11121.110311175249, 11363.090952723596, 11396.088312935111, 11527.308361498337, 11667.59163429276, 11684.18210725241, 11760.000399965757, 11867.228630139014, 8128.715494957648, 10942.085135101484, 11291.435428228391, 11399.430028498708, 11443.370614616277, 7595.430342724429, 7950.085740139958, 8024.478408903403, 8300.667973281, 8315.334773218006, 8680.565971701515, 10888.51001704941, 11045.33727976324, 11611.5355385787, 11921.10591705643], "value": 9284.485496673353, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.7179271834714, 1555.292341984397, 1743.1371471121788, 1830.2495976649568, 1831.8717689761722, 7886.763397098096, 8694.304455643549, 8725.781855453617, 9256.722298331053, 9259.120383563559, 8697.826043479126, 8918.643254269822, 8954.149355811187, 8954.37319387643, 8976.147266009719, 2362.598358279088, 2392.7726865947707, 2396.7842894139526, 2400.939976500584, 2404.386881345263, 2335.92992210234, 2343.871087090209, 2408.036785285882, 2409.3976505873534, 2411.4574220800355, 2382.463945612241, 2386.2125498585424, 2396.760323967598, 2401.795847352977, 2402.267308470916, 2303.193882141254, 2319.8608083514873, 2331.1374791327235, 2335.801456876159, 2338.497223097025, 2327.6973993380752, 2340.368100612842, 2348.2016114520975, 2353.376355265856, 2359.2922123362923, 8944.195022447946, 8990.325725570543, 9022.368434209608, 9025.0, 9027.548622568846, 5348.117560602496, 5426.75579598919, 5437.945620543784, 5439.347278326587, 5537.667739935617, 3582.444721068239, 3584.9641503585153, 3618.1135621772833, 3679.521662183899, 3733.1227161617, 1063.1813503602261, 1106.4080716816545, 1107.058999850129, 1145.7823013627385, 1159.594142050284, 12813.615591532362, 12834.0, 12855.22868627876, 12884.484620615163, 12902.0, 4765.0, 4822.228443449031, 4855.635827312965, 4901.0, 4928.778204980713, 10662.413567253876, 10711.517981690842, 10745.409002504937, 10765.515551800188, 10766.30019048775, 5257.5005374489365, 5468.4531546845, 5539.473749993744, 5543.279373681396, 5597.720113994284, 4396.714213576107, 4954.133026720309, 5067.3412456381175, 5107.131787596118, 5123.8719032023755, 4084.9795751021647, 4172.269852775813, 4176.415301857743, 4207.0, 4299.817550173727, 1281.5450515067016, 1359.3135466589308, 1364.0519838712, 1374.0725010617793, 1375.0580852116332, 869.5565261716444, 874.8643960186181, 970.5583959298502, 990.0742805476903, 1008.5814387029301, 5848.736806843703, 5875.148103524965, 5952.7023648817385, 5959.0, 6110.7861224856915, 1030.7526193713454, 1066.8826429092794, 1080.713610893114, 1089.9182561307935, 1123.3540714089431, 4070.104576993057, 4147.3778933160265, 4168.3955826405, 4178.456800615901, 4187.644050255702, 11087.390193539271, 11375.089992800557, 11448.94275528617, 11461.54153833854, 11462.083033357478, 10491.68524944253, 11420.14348923834, 11437.428128593538, 11440.256383335223, 11507.769844603228, 8220.917790822135, 8602.612882420306, 8609.526476043753, 8612.741617751477, 8695.347848911231, 5666.858328541654, 5889.440503152194, 5982.491488223375, 6006.729697163725, 6114.938850611437, 10081.14310283634, 10215.233857460571, 10334.0, 10335.22485813552, 10493.52779124926, 10414.062734353642, 10490.842637360292, 10576.206784491347, 10594.099501542456, 10683.626073087406, 6760.661966901734, 7312.41500679955, 7545.170031296443, 7786.18245084258, 7880.684772609032, 8568.35737319691, 8569.271611912807, 8593.742187734379, 8610.397272190887, 8646.43798153118, 7052.471064670273, 7346.52247603904, 7421.2207718190975, 7481.588512631857, 7565.735199268, 7176.246494118252, 7254.347108760237, 7310.853782924418, 7323.0, 7395.371393431618, 6742.224644165984, 6767.661616919233, 6791.762288319885, 6801.1158549388265, 6811.148606424197, 4900.289458028495, 5026.170681837456, 5031.295618613471, 5160.458151893997, 5219.712915789516, 5223.242629818731, 5267.73661316925, 5292.655977361459, 5320.973395133, 5331.986922484715], "value": 4746.077331094065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.26190511826553, 347.7322461704488, 349.7114880223815, 352.4853713578176, 353.41862635963855, 5499.450054994499, 5582.609217354787, 5647.689377084259, 5711.228984087147, 5715.657060576368, 5610.186522954169, 5616.9327827712705, 5637.520810731083, 5638.661680299185, 5653.462921022497, 4376.6936314458, 4382.649388048964, 4390.341448782676, 4410.580994805488, 4428.180786554498, 4105.322621767405, 4365.5852693994175, 4377.868663940071, 4404.185225733234, 4409.603135717784, 4293.806778694966, 4298.656107511407, 4315.956840431602, 4321.611055005049, 4325.178216138924, 4336.111097225062, 4336.306191009423, 4351.9782401088105, 4354.629856462205, 4369.541198174178, 3768.7550309229814, 3777.58446570877, 3811.8284677189595, 3842.346801043829, 3846.9807650961566, 5443.646162999432, 5443.863903402446, 5446.700431476267, 5467.835964921059, 5470.604995726104, 4943.678660887031, 4986.4514903360605, 4987.62592805541, 5016.097102521545, 5034.496550344973, 5578.609497335188, 5834.212381328509, 5836.241288632493, 5860.97069514654, 5861.3552509223955, 4123.402106694512, 4143.57046818847, 4146.108586653853, 4147.39862719907, 4166.729147610008, 6207.937920620781, 6233.9999999999545, 6242.968785156045, 6244.0633904914175, 6257.0, 4151.584841515824, 4309.245881970705, 4319.028218650778, 4334.371516130143, 4341.869743907688, 4335.566443355639, 4335.913281734348, 4339.1104823511105, 4347.130573885235, 4368.934465983013, 4987.551120399182, 4995.550400463976, 4999.600031997432, 5007.574356179693, 5035.1188542005, 5849.268841394825, 5949.286085669661, 5973.701314934236, 6024.1566180734735, 6025.78909738157, 1480.0611199328914, 1496.1247670113105, 1507.5251295841774, 1508.5926799764002, 1509.6678730679232, 933.3373304953424, 934.9719508414759, 966.8066386722684, 968.6222373274429, 987.7036888933435, 5070.518300761421, 5081.669691470042, 5083.923741143886, 5122.410922743932, 5160.483951604884, 5338.971190947415, 5347.598930080259, 5408.702521361284, 5470.863228419322, 5478.424765399655, 4918.065567542156, 5008.323876276656, 5062.0, 5072.0109578632555, 5159.561437277798, 2905.898293559715, 2909.53068700305, 2910.63617047869, 2930.223490774946, 2942.6757958918574, 5557.138643510181, 5560.221568980346, 5572.777088916479, 5602.523785478198, 5610.803621873297, 5322.2548843161985, 5475.014497390508, 5497.2958382901425, 5514.8069817557, 5549.223108764776, 5506.843562851846, 5530.778768849201, 5573.777048918079, 5586.190002449704, 5596.656802367484, 5148.124818780741, 5356.384015838073, 5376.220448034935, 5378.220158076979, 5409.891802164014, 5264.552513036281, 5289.814856480005, 5296.629235953446, 5297.894042119059, 5339.7063161526485, 5505.862353441196, 5546.36216835053, 5586.916196256978, 5621.35354434229, 6058.485028772604, 4109.794510274414, 4287.464066991626, 4289.571042895685, 4303.870883873489, 4304.569543045671, 5932.317783454785, 6025.66858822769, 6061.242344706911, 6083.513318934563, 6143.662098584621, 5693.259876216065, 5863.120531920246, 5887.234659494238, 5892.852678683067, 5936.782959493207, 5836.182934389274, 5870.354261031198, 5877.617954832922, 5887.735051922588, 5952.226210592596, 5698.0, 5772.797952071657, 5791.681457519877, 5813.883722325614, 5818.4763371296785, 5829.329627092939, 5956.910646340221, 5965.433283838029, 5966.940330596812, 5972.70136493165, 5732.598718089694, 5772.393898640582, 5798.188253644577, 5840.8247752567495, 5863.560232982458], "value": 4349.084332257722, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.7419206509462, 678.8031470873447, 732.3921145449277, 738.1916801102794, 745.9104907411112, 11791.0, 11967.880321196786, 12374.319412432313, 12429.129960902741, 12441.377931103454, 11898.821517677221, 11904.642860714172, 11907.821382679267, 11955.7608847823, 11957.521699132047, 801.2868546993166, 802.9156938521459, 814.9022117345897, 816.4366587054943, 831.1812864328631, 826.2728798657173, 830.9501429914194, 833.0752864320599, 833.5873742497442, 833.9749807505784, 869.7347309070731, 873.6112429968666, 874.3704532736419, 875.8773771671971, 877.6840337478502, 865.8614621660536, 866.7356456280831, 869.0180096490925, 869.8390797702414, 872.1365847810654, 633.6673246545554, 634.5653227539104, 636.226984214182, 637.91069250305, 639.1052526462943, 12917.160384574972, 13035.608931732064, 13044.41300141496, 13091.279979601119, 13120.868791312156, 13557.389917453738, 13608.931955340258, 13685.521006764815, 13692.794608080887, 13808.1024733393, 10426.218033647507, 10430.530626121767, 10512.579496820117, 10555.683329500127, 10572.52423640938, 3671.4125739881756, 3701.9444708329397, 3707.480952666629, 3753.493278407407, 3766.8304926278383, 52009.47990520084, 52262.47737522614, 52670.47329526694, 53599.46400536023, 53615.99999999961, 10324.277300588887, 10458.895411045944, 10805.405702686428, 10867.619633312795, 11117.444127793578, 16415.097169655546, 16420.0, 16468.917655411646, 16597.668046639, 16650.83349166517, 7308.30571095745, 7338.192798792129, 7404.757290719491, 7430.256974302527, 7606.619669016527, 4410.580994805488, 4515.983903621659, 4516.299973504047, 4559.0, 4682.41469816273, 3223.7582181336493, 3276.770626056201, 3286.7370610351113, 3287.8027318360973, 3290.7860989035635, 739.9112106547249, 748.9737859174903, 752.7139686918936, 760.5056713136505, 772.1120711182185, 696.3767428151775, 715.0918333716152, 721.5418209437046, 745.2770812312049, 746.9663865125974, 8384.16158384169, 8809.986851512158, 9111.954440227757, 9241.399309044891, 9302.813943721223, 622.2129006806304, 742.6954948471101, 748.887666849966, 758.3250906693048, 766.7163149634559, 4070.8575199867864, 4307.138572285556, 4330.090680957034, 4399.6040356368085, 4408.515063343029, 57502.424975750546, 59006.11490827641, 59014.40985590175, 60293.0, 61540.38459615347, 53239.733801330745, 55023.0, 55059.72470137624, 55072.44927550753, 56934.0, 48953.5104648949, 49370.50629493731, 50322.24516632254, 50520.0, 51062.48937510652, 7776.144624091232, 7978.0, 7979.082405523207, 8055.516668999644, 8131.918680813116, 32270.35459290848, 32659.836700816344, 32963.505547417284, 33218.16954576155, 33622.66377336293, 42876.35685464783, 42965.14069718651, 43336.0, 43808.56191438045, 44152.896177595816, 10932.945335273273, 11241.831372529256, 11253.268537545033, 11263.211575189658, 11326.886731132583, 12021.459034343301, 12256.693582660504, 12508.499660013498, 12660.810087848506, 12817.295048772407, 11303.321800691985, 11349.092072634005, 11352.659420217407, 11509.136814739095, 11522.135839812216, 11823.290602563873, 11947.402629868646, 11950.223235489666, 11996.940015299868, 12140.817887731515, 10868.293560918515, 11099.889001109885, 11151.776964460827, 11287.830682539605, 11451.713707157387, 9119.0, 9544.761380965532, 9611.375260608038, 9812.509374531388, 9853.06395892389, 9289.6284148636, 9547.236221102434, 9686.854697179408, 9847.901520984986, 10013.59945602197], "value": 6449.700173505534, "unit": "score"}], "name": "dromaeo_css", "value": 7083.319643212595, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 105.0, 111.0, 111.0, 112.0, 105.0, 112.0, 112.0, 113.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 134.0, 151.0, 219.0, 127.0, 166.0, 159.0, 135.0, 191.0, 127.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 163.0, 174.0, 163.0, 164.0, 164.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 76.0, 172.0, 76.0, 76.0, 75.0, 77.0, 165.0, 76.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 181.0, 92.0, 93.0, 94.0, 144.0, 93.0, 92.0, 159.0], "value": 113.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 58.0, 62.0, 58.0, 63.0, 113.0, 56.0, 56.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 80.0, 88.0, 80.0, 78.0, 80.0, 81.0, 82.0, 82.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 126.0, 127.0, 137.0, 126.0, 141.0, 123.0, 139.0, 191.0, 133.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 171.0, 173.0, 172.0, 171.0, 181.0, 171.0, 167.0, 174.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 67.0, 70.0, 69.0, 68.0, 67.0, 65.0, 65.0, 64.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1581.0, "alertThreshold": 2.0}]} 17:28:56 INFO - Return code: 0 17:28:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:28:56 ERROR - # TBPL SUCCESS # 17:28:56 INFO - Running post-action listener: _resource_record_post_action 17:28:56 INFO - ##### 17:28:56 INFO - ##### Finished run-tests step (success) 17:28:56 INFO - ##### 17:28:56 INFO - Running post-run listener: _resource_record_post_run 17:28:57 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509022208; Read time: 12; Write time: 452012 17:28:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 123379712; Read time: 0; Write time: 119976 17:28:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284000256; Read time: 12; Write time: 223896 17:28:57 INFO - Running post-run listener: _upload_blobber_files 17:28:57 INFO - Blob upload gear active. 17:28:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:28:57 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:28:57 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:28:57 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:28:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:59 INFO - (blobuploader) - INFO - Done attempting. 17:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:59 INFO - (blobuploader) - INFO - Done attempting. 17:28:59 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:59 INFO - Return code: 0 17:28:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:28:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/610840347c81b32159aedcdcf29c62e48f5dff94a66dff4005f1a74a6154aa4d540f9a640e6ed0b65e06011dd715bad3737dc0834e6a473ca07cdf0843507547", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2805d921e9a46add5d6f4e98a52aec060f040dbd442d0d309db74883a00880ae6655f336eac895d99f5bc69b5ad4f139b93f82dfe51e198888cdf1a62ade0642"} 17:28:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:28:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:28:59 INFO - Contents: 17:28:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/610840347c81b32159aedcdcf29c62e48f5dff94a66dff4005f1a74a6154aa4d540f9a640e6ed0b65e06011dd715bad3737dc0834e6a473ca07cdf0843507547", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2805d921e9a46add5d6f4e98a52aec060f040dbd442d0d309db74883a00880ae6655f336eac895d99f5bc69b5ad4f139b93f82dfe51e198888cdf1a62ade0642"} 17:28:59 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:59 INFO - Copying logs to upload dir... 17:28:59 INFO - mkdir: /builds/slave/test/build/upload/logs 17:28:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.432295 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-10 17:28:58.142860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 17:28:58.145919) ========= 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=574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434 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/610840347c81b32159aedcdcf29c62e48f5dff94a66dff4005f1a74a6154aa4d540f9a640e6ed0b65e06011dd715bad3737dc0834e6a473ca07cdf0843507547", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2805d921e9a46add5d6f4e98a52aec060f040dbd442d0d309db74883a00880ae6655f336eac895d99f5bc69b5ad4f139b93f82dfe51e198888cdf1a62ade0642"} 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.011123 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/610840347c81b32159aedcdcf29c62e48f5dff94a66dff4005f1a74a6154aa4d540f9a640e6ed0b65e06011dd715bad3737dc0834e6a473ca07cdf0843507547", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2805d921e9a46add5d6f4e98a52aec060f040dbd442d0d309db74883a00880ae6655f336eac895d99f5bc69b5ad4f139b93f82dfe51e198888cdf1a62ade0642"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 17:28:58.170075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:28:58.170405) ========= 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=574dc5aafe09851ec43d388c000001b6-1462925306.946682-1582447434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:28:58.253234) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 17:28:58.253559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 17:28:58.253844) ========= ========= Total master_lag: 0.16 =========