builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1461699905.19 results: success (0) buildid: 20160426120641 builduid: 7cb853e62e4c4fd68d0ab47d1a77adb5 revision: 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:05.194936) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:05.195410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:05.195796) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:05.218042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:05.218320) ========= 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=ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 12:45:06-- 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% 71.0M=0s 2016-04-26 12:45:06 (71.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:05.358142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:05.358692) ========= 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=ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:05.409171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 12:45:05.409530) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 --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 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 --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=ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 12:45:06,497 truncating revision to first 12 chars 2016-04-26 12:45:06,498 Setting DEBUG logging. 2016-04-26 12:45:06,498 attempt 1/10 2016-04-26 12:45:06,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6bbcf33e1a70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 12:45:07,613 unpacking tar archive at: fx-team-6bbcf33e1a70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.428760 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 12:45:06.852921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:06.853463) ========= script_repo_revision: 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:06.854131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:06.854554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 12:45:06.873796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-26 12:45:06.874076) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:45:08 INFO - MultiFileLogger online at 20160426 12:45:08 in /builds/slave/test 12:45:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:45:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:45:08 INFO - {'append_to_log': False, 12:45:08 INFO - 'base_work_dir': '/builds/slave/test', 12:45:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:45:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:45:08 INFO - 'branch': 'Fx-Team-Non-PGO', 12:45:08 INFO - 'buildbot_json_path': 'buildprops.json', 12:45:08 INFO - 'config_files': ('talos/linux_config.py',), 12:45:08 INFO - 'default_actions': ('clobber', 12:45:08 INFO - 'read-buildbot-config', 12:45:08 INFO - 'download-and-extract', 12:45:08 INFO - 'populate-webroot', 12:45:08 INFO - 'create-virtualenv', 12:45:08 INFO - 'install', 12:45:08 INFO - 'run-tests'), 12:45:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:45:08 INFO - 'download_minidump_stackwalk': True, 12:45:08 INFO - 'download_symbols': 'ondemand', 12:45:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:45:08 INFO - 'tooltool.py': '/tools/tooltool.py', 12:45:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:45:08 INFO - '/tools/misc-python/virtualenv.py')}, 12:45:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:45:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:45:08 INFO - 'installer_path': 'installer.exe', 12:45:08 INFO - 'log_level': 'info', 12:45:08 INFO - 'log_name': 'talos', 12:45:08 INFO - 'log_to_console': True, 12:45:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:45:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:45:08 INFO - 'opt_config_files': (), 12:45:08 INFO - 'pip_index': False, 12:45:08 INFO - 'sps_profile': False, 12:45:08 INFO - 'sps_profile_interval': 0, 12:45:08 INFO - 'suite': 'dromaeojs-e10s', 12:45:08 INFO - 'system_bits': '32', 12:45:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:45:08 INFO - 'title': 'talos-linux64-ix-035', 12:45:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:45:08 INFO - 'use_talos_json': True, 12:45:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:45:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:45:08 INFO - 'work_dir': 'build'} 12:45:08 INFO - ##### 12:45:08 INFO - ##### Running clobber step. 12:45:08 INFO - ##### 12:45:08 INFO - Running pre-action listener: _resource_record_pre_action 12:45:08 INFO - Running main action method: clobber 12:45:08 INFO - rmtree: /builds/slave/test/build 12:45:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:45:08 INFO - Running post-action listener: _resource_record_post_action 12:45:08 INFO - ##### 12:45:08 INFO - ##### Running read-buildbot-config step. 12:45:08 INFO - ##### 12:45:08 INFO - Running pre-action listener: _resource_record_pre_action 12:45:08 INFO - Running main action method: read_buildbot_config 12:45:08 INFO - Using buildbot properties: 12:45:08 INFO - { 12:45:08 INFO - "project": "", 12:45:08 INFO - "product": "firefox", 12:45:08 INFO - "script_repo_revision": "production", 12:45:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:45:08 INFO - "repository": "", 12:45:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:45:08 INFO - "buildid": "20160426120641", 12:45:08 INFO - "pgo_build": "False", 12:45:08 INFO - "basedir": "/builds/slave/test", 12:45:08 INFO - "buildnumber": 1210, 12:45:08 INFO - "slavename": "talos-linux64-ix-035", 12:45:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:45:08 INFO - "platform": "ubuntu64_hw", 12:45:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:45:08 INFO - "branch": "fx-team", 12:45:08 INFO - "repo_path": "integration/fx-team", 12:45:08 INFO - "revision": "6bbcf33e1a709cc6bd9a9ab73e303093fc748239", 12:45:08 INFO - "stage_platform": "linux64", 12:45:08 INFO - "builduid": "7cb853e62e4c4fd68d0ab47d1a77adb5", 12:45:08 INFO - "slavebuilddir": "test" 12:45:08 INFO - } 12:45:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:45:08 INFO - Running post-action listener: _resource_record_post_action 12:45:08 INFO - ##### 12:45:08 INFO - ##### Running download-and-extract step. 12:45:08 INFO - ##### 12:45:08 INFO - Running pre-action listener: _resource_record_pre_action 12:45:08 INFO - Running main action method: download_and_extract 12:45:08 INFO - mkdir: /builds/slave/test/build/tests 12:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:08 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:13 INFO - Downloaded 1361 bytes. 12:45:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:45:13 INFO - Using the following test package requirements: 12:45:13 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:45:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:45:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:45:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:13 INFO - u'jsshell-linux-x86_64.zip'], 12:45:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:45:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:45:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:45:13 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:45:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:45:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:45:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:45:13 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')]} 12:45:13 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:45:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:45:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:14 INFO - Downloaded 22291062 bytes. 12:45:14 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'] 12:45:14 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 12:45:16 INFO - Return code: 0 12:45:16 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 12:45:16 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')]} 12:45:16 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:45:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:45:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:17 INFO - Downloaded 22291062 bytes. 12:45:17 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'] 12:45:17 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 12:45:19 INFO - Return code: 0 12:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:19 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:45:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:21 INFO - Downloaded 10840145 bytes. 12:45:21 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'] 12:45:21 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 12:45:21 INFO - Return code: 0 12:45: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')]} 12:45:21 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:45:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:45:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:45:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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 12:45:26 INFO - Downloaded 54817523 bytes. 12:45:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:45:26 INFO - mkdir: /builds/slave/test/properties 12:45:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:45:26 INFO - Writing to file /builds/slave/test/properties/build_url 12:45:26 INFO - Contents: 12:45:26 INFO - build_url:https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:45:28 INFO - Running post-action listener: _resource_record_post_action 12:45:28 INFO - Running post-action listener: set_extra_try_arguments 12:45:28 INFO - ##### 12:45:28 INFO - ##### Running populate-webroot step. 12:45:28 INFO - ##### 12:45:28 INFO - Running pre-action listener: _resource_record_pre_action 12:45:28 INFO - Running main action method: populate_webroot 12:45:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:45:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:45:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:45:28 INFO - '--tppagecycles', 12:45:28 INFO - '7'], 12:45:28 INFO - 'tests': ['tsvgm']}}, 12:45:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:45:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:45:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:45:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:45:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:28 INFO - 'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:28 INFO - 'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['damp', 'tps']}, 12:45:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:28 INFO - 'tests': ['damp', 'tps']}, 12:45:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['dromaeo_dom']}, 12:45:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:45:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['a11yr', 12:45:28 INFO - 'ts_paint', 12:45:28 INFO - 'tpaint', 12:45:28 INFO - 'sessionrestore', 12:45:28 INFO - 'sessionrestore_no_auto_restore', 12:45:28 INFO - 'tabpaint']}, 12:45:28 INFO - 'other-e10s': {'tests': ['a11yr', 12:45:28 INFO - 'ts_paint', 12:45:28 INFO - 'tpaint', 12:45:28 INFO - 'sessionrestore', 12:45:28 INFO - 'sessionrestore_no_auto_restore', 12:45:28 INFO - 'tabpaint']}, 12:45:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:45:28 INFO - 'ts_paint', 12:45:28 INFO - 'tpaint', 12:45:28 INFO - 'sessionrestore', 12:45:28 INFO - 'sessionrestore_no_auto_restore', 12:45:28 INFO - 'tabpaint']}, 12:45:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:45:28 INFO - 'ts_paint', 12:45:28 INFO - 'tpaint', 12:45:28 INFO - 'sessionrestore', 12:45:28 INFO - 'sessionrestore_no_auto_restore', 12:45:28 INFO - 'tabpaint']}, 12:45:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['a11yr', 12:45:28 INFO - 'ts_paint', 12:45:28 INFO - 'tpaint', 12:45:28 INFO - 'sessionrestore', 12:45:28 INFO - 'sessionrestore_no_auto_restore', 12:45:28 INFO - 'tabpaint']}, 12:45:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['a11yr', 12:45:28 INFO - 'ts_paint', 12:45:28 INFO - 'tpaint', 12:45:28 INFO - 'sessionrestore', 12:45:28 INFO - 'sessionrestore_no_auto_restore', 12:45:28 INFO - 'tabpaint']}, 12:45:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['tsvgx', 12:45:28 INFO - 'tsvgr_opacity', 12:45:28 INFO - 'tart', 12:45:28 INFO - 'tscrollx', 12:45:28 INFO - 'cart']}, 12:45:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:45:28 INFO - 'tsvgr_opacity', 12:45:28 INFO - 'tart', 12:45:28 INFO - 'tscrollx', 12:45:28 INFO - 'cart']}, 12:45:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:28 INFO - 'talos_options': ['--disable-e10s'], 12:45:28 INFO - 'tests': ['tp5o']}, 12:45:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:28 INFO - 'tests': ['tp5o']}, 12:45:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:28 INFO - 'talos_options': ['--disable-e10s', 12:45:28 INFO - '--xperf_path', 12:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:28 INFO - 'tests': ['tp5n']}, 12:45:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:28 INFO - 'talos_options': ['--xperf_path', 12:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:28 INFO - 'tests': ['tp5n']}}, 12:45:28 INFO - 'talos.zip': {'path': '', 12:45:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:45:28 INFO - Running post-action listener: _resource_record_post_action 12:45:28 INFO - ##### 12:45:28 INFO - ##### Running create-virtualenv step. 12:45:28 INFO - ##### 12:45:28 INFO - Running pre-action listener: _resource_record_pre_action 12:45:28 INFO - Running main action method: create_virtualenv 12:45:28 INFO - Creating virtualenv /builds/slave/test/build/venv 12:45:28 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 12:45:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:45:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:45:28 INFO - Using real prefix '/usr' 12:45:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:45:29 INFO - Installing distribute.............................................................................................................................................................................................done. 12:45:31 INFO - Installing pip.................done. 12:45:31 INFO - Return code: 0 12:45:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:31 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 0x7efff556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', '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 12:45:31 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 12:45:31 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 12:45:31 INFO - Using env: {'DISPLAY': ':0', 12:45:31 INFO - 'HOME': '/home/cltbld', 12:45:31 INFO - 'LANG': 'en_US.UTF-8', 12:45:31 INFO - 'LANGUAGE': 'en_US:en', 12:45:31 INFO - 'LOGNAME': 'cltbld', 12:45:31 INFO - 'MAIL': '/var/mail/cltbld', 12:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:31 INFO - 'MOZ_NO_REMOTE': '1', 12:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:31 INFO - 'NO_EM_RESTART': '1', 12:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:31 INFO - 'PWD': '/builds/slave/test', 12:45:31 INFO - 'SHELL': '/bin/bash', 12:45:31 INFO - 'SHLVL': '1', 12:45:31 INFO - 'TERM': 'linux', 12:45:31 INFO - 'TMOUT': '86400', 12:45:31 INFO - 'USER': 'cltbld', 12:45:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:31 INFO - '_': '/tools/buildbot/bin/python'} 12:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:31 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 12:45:31 INFO - Cleaning up... 12:45:31 INFO - Return code: 0 12:45:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:31 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 0x7efff556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', '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 12:45:31 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 12:45:31 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 12:45:31 INFO - Using env: {'DISPLAY': ':0', 12:45:31 INFO - 'HOME': '/home/cltbld', 12:45:31 INFO - 'LANG': 'en_US.UTF-8', 12:45:31 INFO - 'LANGUAGE': 'en_US:en', 12:45:31 INFO - 'LOGNAME': 'cltbld', 12:45:31 INFO - 'MAIL': '/var/mail/cltbld', 12:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:31 INFO - 'MOZ_NO_REMOTE': '1', 12:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:31 INFO - 'NO_EM_RESTART': '1', 12:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:31 INFO - 'PWD': '/builds/slave/test', 12:45:31 INFO - 'SHELL': '/bin/bash', 12:45:31 INFO - 'SHLVL': '1', 12:45:31 INFO - 'TERM': 'linux', 12:45:31 INFO - 'TMOUT': '86400', 12:45:31 INFO - 'USER': 'cltbld', 12:45:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:31 INFO - '_': '/tools/buildbot/bin/python'} 12:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:31 INFO - Downloading/unpacking psutil>=0.7.1 12:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:45:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:33 INFO - Installing collected packages: psutil 12:45:33 INFO - Running setup.py install for psutil 12:45:33 INFO - building 'psutil._psutil_linux' extension 12:45:33 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 12:45:33 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 12:45:33 INFO - building 'psutil._psutil_posix' extension 12:45:33 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 12:45:34 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 12:45:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:34 INFO - Successfully installed psutil 12:45:34 INFO - Cleaning up... 12:45:34 INFO - Return code: 0 12:45:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7efff556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', '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 12:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:45:34 INFO - Using env: {'DISPLAY': ':0', 12:45:34 INFO - 'HOME': '/home/cltbld', 12:45:34 INFO - 'LANG': 'en_US.UTF-8', 12:45:34 INFO - 'LANGUAGE': 'en_US:en', 12:45:34 INFO - 'LOGNAME': 'cltbld', 12:45:34 INFO - 'MAIL': '/var/mail/cltbld', 12:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:34 INFO - 'MOZ_NO_REMOTE': '1', 12:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:34 INFO - 'NO_EM_RESTART': '1', 12:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:34 INFO - 'PWD': '/builds/slave/test', 12:45:34 INFO - 'SHELL': '/bin/bash', 12:45:34 INFO - 'SHLVL': '1', 12:45:34 INFO - 'TERM': 'linux', 12:45:34 INFO - 'TMOUT': '86400', 12:45:34 INFO - 'USER': 'cltbld', 12:45:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:34 INFO - '_': '/tools/buildbot/bin/python'} 12:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:45:34 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 12:45:34 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 12:45:34 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 12:45:34 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 12:45:34 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 12:45:34 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 12:45:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:45:36 INFO - Installing collected packages: mozsystemmonitor 12:45:36 INFO - Running setup.py install for mozsystemmonitor 12:45:36 INFO - Successfully installed mozsystemmonitor 12:45:36 INFO - Cleaning up... 12:45:36 INFO - Return code: 0 12:45:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:45: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')]} 12:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45: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')]} 12:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:36 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 0x7efff556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', '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 12:45:36 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 12:45:36 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 12:45:36 INFO - Using env: {'DISPLAY': ':0', 12:45:36 INFO - 'HOME': '/home/cltbld', 12:45:36 INFO - 'LANG': 'en_US.UTF-8', 12:45:36 INFO - 'LANGUAGE': 'en_US:en', 12:45:36 INFO - 'LOGNAME': 'cltbld', 12:45:36 INFO - 'MAIL': '/var/mail/cltbld', 12:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:36 INFO - 'MOZ_NO_REMOTE': '1', 12:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:36 INFO - 'NO_EM_RESTART': '1', 12:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:36 INFO - 'PWD': '/builds/slave/test', 12:45:36 INFO - 'SHELL': '/bin/bash', 12:45:36 INFO - 'SHLVL': '1', 12:45:36 INFO - 'TERM': 'linux', 12:45:36 INFO - 'TMOUT': '86400', 12:45:36 INFO - 'USER': 'cltbld', 12:45:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:36 INFO - '_': '/tools/buildbot/bin/python'} 12:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:36 INFO - Downloading/unpacking blobuploader==1.2.4 12:45:36 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 12:45:36 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 12:45:36 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 12:45:36 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 12:45:36 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 12:45:36 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 12:45:38 INFO - Downloading blobuploader-1.2.4.tar.gz 12:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:45:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:45:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:39 INFO - Downloading docopt-0.6.1.tar.gz 12:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:45:39 INFO - Installing collected packages: blobuploader, requests, docopt 12:45:39 INFO - Running setup.py install for blobuploader 12:45:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:45:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:45:39 INFO - Running setup.py install for requests 12:45:39 INFO - Running setup.py install for docopt 12:45:39 INFO - Successfully installed blobuploader requests docopt 12:45:39 INFO - Cleaning up... 12:45:39 INFO - Return code: 0 12:45:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:39 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')]} 12:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:39 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')]} 12:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:39 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 0x7efff556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', '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 12:45:39 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 12:45:39 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 12:45:39 INFO - Using env: {'DISPLAY': ':0', 12:45:39 INFO - 'HOME': '/home/cltbld', 12:45:39 INFO - 'LANG': 'en_US.UTF-8', 12:45:39 INFO - 'LANGUAGE': 'en_US:en', 12:45:39 INFO - 'LOGNAME': 'cltbld', 12:45:39 INFO - 'MAIL': '/var/mail/cltbld', 12:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:39 INFO - 'MOZ_NO_REMOTE': '1', 12:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:39 INFO - 'NO_EM_RESTART': '1', 12:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:39 INFO - 'PWD': '/builds/slave/test', 12:45:39 INFO - 'SHELL': '/bin/bash', 12:45:39 INFO - 'SHLVL': '1', 12:45:39 INFO - 'TERM': 'linux', 12:45:39 INFO - 'TMOUT': '86400', 12:45:39 INFO - 'USER': 'cltbld', 12:45:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:39 INFO - '_': '/tools/buildbot/bin/python'} 12:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:40 INFO - Running setup.py (path:/tmp/pip-__jOmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:40 INFO - Running setup.py (path:/tmp/pip-pS5Fxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:40 INFO - Running setup.py (path:/tmp/pip-kcMATT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:40 INFO - Running setup.py (path:/tmp/pip-R8Xs7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:40 INFO - Running setup.py (path:/tmp/pip-jZ8CA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:40 INFO - Running setup.py (path:/tmp/pip-n9hjN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:40 INFO - Running setup.py (path:/tmp/pip-enRFWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:40 INFO - Running setup.py (path:/tmp/pip-68xIAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:40 INFO - Running setup.py (path:/tmp/pip-qciTSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:40 INFO - Running setup.py (path:/tmp/pip-1ewFDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:40 INFO - Running setup.py (path:/tmp/pip-iAmV4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:40 INFO - Running setup.py (path:/tmp/pip-EblVCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:40 INFO - Running setup.py (path:/tmp/pip-14loy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:40 INFO - Running setup.py (path:/tmp/pip-PcHVsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:41 INFO - Running setup.py (path:/tmp/pip-hmT3Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:41 INFO - Running setup.py (path:/tmp/pip-6WRV7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:41 INFO - Running setup.py (path:/tmp/pip-9rLPa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:45:41 INFO - Running setup.py install for manifestparser 12:45:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Running setup.py install for mozcrash 12:45:41 INFO - Running setup.py install for mozdebug 12:45:41 INFO - Running setup.py install for mozdevice 12:45:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Running setup.py install for mozfile 12:45:41 INFO - Running setup.py install for mozhttpd 12:45:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Running setup.py install for mozinfo 12:45:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Running setup.py install for mozInstall 12:45:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Running setup.py install for mozleak 12:45:42 INFO - Running setup.py install for mozlog 12:45:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Running setup.py install for moznetwork 12:45:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Running setup.py install for mozprocess 12:45:42 INFO - Running setup.py install for mozprofile 12:45:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Running setup.py install for mozrunner 12:45:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Running setup.py install for mozscreenshot 12:45:42 INFO - Running setup.py install for moztest 12:45:42 INFO - Running setup.py install for mozversion 12:45:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:45:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:45:43 INFO - Cleaning up... 12:45:43 INFO - Return code: 0 12:45:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45: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')]} 12:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45: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')]} 12:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:43 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 0x7efff556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', '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 12:45:43 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 12:45:43 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 12:45:43 INFO - Using env: {'DISPLAY': ':0', 12:45:43 INFO - 'HOME': '/home/cltbld', 12:45:43 INFO - 'LANG': 'en_US.UTF-8', 12:45:43 INFO - 'LANGUAGE': 'en_US:en', 12:45:43 INFO - 'LOGNAME': 'cltbld', 12:45:43 INFO - 'MAIL': '/var/mail/cltbld', 12:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:43 INFO - 'MOZ_NO_REMOTE': '1', 12:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:43 INFO - 'NO_EM_RESTART': '1', 12:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:43 INFO - 'PWD': '/builds/slave/test', 12:45:43 INFO - 'SHELL': '/bin/bash', 12:45:43 INFO - 'SHLVL': '1', 12:45:43 INFO - 'TERM': 'linux', 12:45:43 INFO - 'TMOUT': '86400', 12:45:43 INFO - 'USER': 'cltbld', 12:45:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:43 INFO - '_': '/tools/buildbot/bin/python'} 12:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:43 INFO - Running setup.py (path:/tmp/pip-9fMG4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:43 INFO - Running setup.py (path:/tmp/pip-v23M9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:43 INFO - Running setup.py (path:/tmp/pip-v765eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:43 INFO - Running setup.py (path:/tmp/pip-VLmrUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:43 INFO - Running setup.py (path:/tmp/pip-zc4JpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:43 INFO - Running setup.py (path:/tmp/pip-qVyG4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:43 INFO - Running setup.py (path:/tmp/pip-1Gn8zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:43 INFO - Running setup.py (path:/tmp/pip-Klef2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:43 INFO - Running setup.py (path:/tmp/pip-kjKlCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:43 INFO - Running setup.py (path:/tmp/pip-1rc22Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:43 INFO - Running setup.py (path:/tmp/pip-YmO8UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:44 INFO - Running setup.py (path:/tmp/pip-zfvvZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:44 INFO - Running setup.py (path:/tmp/pip-pxui_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:44 INFO - Running setup.py (path:/tmp/pip-VZ1S56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:44 INFO - Running setup.py (path:/tmp/pip-J3eISb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:44 INFO - Running setup.py (path:/tmp/pip-lxN7BL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:44 INFO - Running setup.py (path:/tmp/pip-uG6QbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:44 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)) 12:45:44 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)) 12:45:44 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)) 12:45:44 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)) 12:45:44 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)) 12:45:44 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)) 12:45:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:45:44 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 12:45:44 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 12:45:44 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 12:45:44 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 12:45:44 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 12:45:44 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 12:45:46 INFO - Downloading blessings-1.6.tar.gz 12:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:45:46 INFO - Installing collected packages: blessings 12:45:46 INFO - Running setup.py install for blessings 12:45:46 INFO - Successfully installed blessings 12:45:46 INFO - Cleaning up... 12:45:46 INFO - Return code: 0 12:45:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:45:46 INFO - Reading from file tmpfile_stdout 12:45:46 INFO - Current package versions: 12:45:46 INFO - argparse == 1.2.1 12:45:46 INFO - blessings == 1.6 12:45:46 INFO - blobuploader == 1.2.4 12:45:46 INFO - docopt == 0.6.1 12:45:46 INFO - manifestparser == 1.1 12:45:46 INFO - mozInstall == 1.12 12:45:46 INFO - mozcrash == 0.17 12:45:46 INFO - mozdebug == 0.1 12:45:46 INFO - mozdevice == 0.48 12:45:46 INFO - mozfile == 1.2 12:45:46 INFO - mozhttpd == 0.7 12:45:46 INFO - mozinfo == 0.9 12:45:46 INFO - mozleak == 0.1 12:45:46 INFO - mozlog == 3.1 12:45:46 INFO - moznetwork == 0.27 12:45:46 INFO - mozprocess == 0.22 12:45:46 INFO - mozprofile == 0.28 12:45:46 INFO - mozrunner == 6.11 12:45:46 INFO - mozscreenshot == 0.1 12:45:46 INFO - mozsystemmonitor == 0.0 12:45:46 INFO - moztest == 0.7 12:45:46 INFO - mozversion == 1.4 12:45:46 INFO - psutil == 3.1.1 12:45:46 INFO - requests == 1.2.3 12:45:46 INFO - wsgiref == 0.1.2 12:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45: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')]} 12:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45: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')]} 12:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:46 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 0x7efff556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', '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 12:45:46 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 12:45:46 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 12:45:46 INFO - Using env: {'DISPLAY': ':0', 12:45:46 INFO - 'HOME': '/home/cltbld', 12:45:46 INFO - 'LANG': 'en_US.UTF-8', 12:45:46 INFO - 'LANGUAGE': 'en_US:en', 12:45:46 INFO - 'LOGNAME': 'cltbld', 12:45:46 INFO - 'MAIL': '/var/mail/cltbld', 12:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:46 INFO - 'MOZ_NO_REMOTE': '1', 12:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:46 INFO - 'NO_EM_RESTART': '1', 12:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:46 INFO - 'PWD': '/builds/slave/test', 12:45:46 INFO - 'SHELL': '/bin/bash', 12:45:46 INFO - 'SHLVL': '1', 12:45:46 INFO - 'TERM': 'linux', 12:45:46 INFO - 'TMOUT': '86400', 12:45:46 INFO - 'USER': 'cltbld', 12:45:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:46 INFO - '_': '/tools/buildbot/bin/python'} 12:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 INFO - Cleaning up... 12:45:47 INFO - Return code: 0 12:45:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:45:47 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')]} 12:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 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')]} 12:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 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 0x7efff556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', '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 12:45:47 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 12:45:47 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 12:45:47 INFO - Using env: {'DISPLAY': ':0', 12:45:47 INFO - 'HOME': '/home/cltbld', 12:45:47 INFO - 'LANG': 'en_US.UTF-8', 12:45:47 INFO - 'LANGUAGE': 'en_US:en', 12:45:47 INFO - 'LOGNAME': 'cltbld', 12:45:47 INFO - 'MAIL': '/var/mail/cltbld', 12:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:47 INFO - 'MOZ_NO_REMOTE': '1', 12:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:47 INFO - 'NO_EM_RESTART': '1', 12:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:47 INFO - 'PWD': '/builds/slave/test', 12:45:47 INFO - 'SHELL': '/bin/bash', 12:45:47 INFO - 'SHLVL': '1', 12:45:47 INFO - 'TERM': 'linux', 12:45:47 INFO - 'TMOUT': '86400', 12:45:47 INFO - 'USER': 'cltbld', 12:45:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:47 INFO - '_': '/tools/buildbot/bin/python'} 12:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:47 INFO - Downloading/unpacking jsonschema 12:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:45:49 INFO - Downloading/unpacking functools32 (from jsonschema) 12:45:49 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 12:45:49 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 12:45:49 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 12:45:49 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 12:45:49 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 12:45:49 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 12:45:49 INFO - Downloading functools32-3.2.3-2.tar.gz 12:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:45:49 INFO - warning: no files found matching '*.txt' 12:45:49 INFO - no previously-included directories found matching 'build' 12:45:49 INFO - no previously-included directories found matching 'dist' 12:45:49 INFO - no previously-included directories found matching '.git*' 12:45:49 INFO - Installing collected packages: jsonschema, functools32 12:45:49 INFO - Running setup.py install for functools32 12:45:49 INFO - warning: no files found matching '*.txt' 12:45:49 INFO - no previously-included directories found matching 'build' 12:45:49 INFO - no previously-included directories found matching 'dist' 12:45:49 INFO - no previously-included directories found matching '.git*' 12:45:49 INFO - Successfully installed jsonschema functools32 12:45:49 INFO - Cleaning up... 12:45:49 INFO - Return code: 0 12:45:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:49 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 0x7efff556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', '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 12:45:49 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 12:45:49 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 12:45:49 INFO - Using env: {'DISPLAY': ':0', 12:45:49 INFO - 'HOME': '/home/cltbld', 12:45:49 INFO - 'LANG': 'en_US.UTF-8', 12:45:49 INFO - 'LANGUAGE': 'en_US:en', 12:45:49 INFO - 'LOGNAME': 'cltbld', 12:45:49 INFO - 'MAIL': '/var/mail/cltbld', 12:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:49 INFO - 'MOZ_NO_REMOTE': '1', 12:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:49 INFO - 'NO_EM_RESTART': '1', 12:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:49 INFO - 'PWD': '/builds/slave/test', 12:45:49 INFO - 'SHELL': '/bin/bash', 12:45:49 INFO - 'SHLVL': '1', 12:45:49 INFO - 'TERM': 'linux', 12:45:49 INFO - 'TMOUT': '86400', 12:45:49 INFO - 'USER': 'cltbld', 12:45:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:49 INFO - '_': '/tools/buildbot/bin/python'} 12:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:49 INFO - Downloading/unpacking flake8 12:45:49 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 12:45:49 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 12:45:49 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 12:45:49 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 12:45:49 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 12:45:49 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 12:45:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:45:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:45:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:45:52 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 12:45:52 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 12:45:52 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 12:45:52 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 12:45:52 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 12:45:52 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 12:45:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:45:52 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 12:45:52 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 12:45:52 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 12:45:52 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 12:45:52 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 12:45:52 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 12:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:45:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:45:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:45:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:45:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:45:52 INFO - no previously-included directories found matching 'docs/_build' 12:45:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:45:52 INFO - Running setup.py install for pep8 12:45:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:45:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:45:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:45:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:45:52 INFO - no previously-included directories found matching 'docs/_build' 12:45:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:45:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:45:52 INFO - Cleaning up... 12:45:52 INFO - Return code: 0 12:45:52 INFO - Running post-action listener: _resource_record_post_action 12:45:52 INFO - Running post-action listener: _start_resource_monitoring 12:45:52 INFO - Starting resource monitoring. 12:45:52 INFO - ##### 12:45:52 INFO - ##### Running install step. 12:45:52 INFO - ##### 12:45:52 INFO - Running pre-action listener: _resource_record_pre_action 12:45:52 INFO - Running main action method: install 12:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:45:53 INFO - Reading from file tmpfile_stdout 12:45:53 INFO - Detecting whether we're running mozinstall >=1.0... 12:45:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:45:53 INFO - Reading from file tmpfile_stdout 12:45:53 INFO - Output received: 12:45:53 INFO - Usage: mozinstall [options] installer 12:45:53 INFO - Options: 12:45:53 INFO - -h, --help show this help message and exit 12:45:53 INFO - -d DEST, --destination=DEST 12:45:53 INFO - Directory to install application into. [default: 12:45:53 INFO - "/builds/slave/test"] 12:45:53 INFO - --app=APP Application being installed. [default: firefox] 12:45:53 INFO - mkdir: /builds/slave/test/build/application 12:45:53 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'] 12:45:53 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 12:46:08 INFO - Reading from file tmpfile_stdout 12:46:08 INFO - Output received: 12:46:08 INFO - /builds/slave/test/build/application/firefox/firefox 12:46:08 INFO - Running post-action listener: _resource_record_post_action 12:46:08 INFO - ##### 12:46:08 INFO - ##### Running run-tests step. 12:46:08 INFO - ##### 12:46:08 INFO - Running pre-action listener: _resource_record_pre_action 12:46:08 INFO - Running main action method: run_tests 12:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:46:08 INFO - Python 2.7.3 12:46:08 INFO - Return code: 0 12:46:08 INFO - grabbing minidump binary from tooltool 12:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:08 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 0x2904410>, '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 0x2905310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29057a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:46:08 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 12:46:08 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 12:46:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:46:08 INFO - Return code: 0 12:46:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:46:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:46:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:46:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:46:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:46:09 INFO - Return code: 0 12:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 12:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 12:46:09 INFO - Using env: {'DISPLAY': ':0', 12:46:09 INFO - 'HOME': '/home/cltbld', 12:46:09 INFO - 'LANG': 'en_US.UTF-8', 12:46:09 INFO - 'LANGUAGE': 'en_US:en', 12:46:09 INFO - 'LOGNAME': 'cltbld', 12:46:09 INFO - 'MAIL': '/var/mail/cltbld', 12:46:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:46:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:09 INFO - 'MOZ_NO_REMOTE': '1', 12:46:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:09 INFO - 'NO_EM_RESTART': '1', 12:46:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:09 INFO - 'PWD': '/builds/slave/test', 12:46:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:46:09 INFO - 'SHELL': '/bin/bash', 12:46:09 INFO - 'SHLVL': '1', 12:46:09 INFO - 'TERM': 'linux', 12:46:09 INFO - 'TMOUT': '86400', 12:46:09 INFO - 'USER': 'cltbld', 12:46:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208', 12:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:09 INFO - '_': '/tools/buildbot/bin/python'} 12:46:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 12:46:10 INFO - mozversion application_buildid: 20160426120641 12:46:10 INFO - mozversion application_changeset: 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 12:46:10 INFO - mozversion application_display_name: Nightly 12:46:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:46:10 INFO - mozversion application_name: Firefox 12:46:10 INFO - mozversion application_remotingname: firefox 12:46:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:46:10 INFO - mozversion application_vendor: Mozilla 12:46:10 INFO - mozversion application_version: 49.0a1 12:46:10 INFO - mozversion platform_buildid: 20160426120641 12:46:10 INFO - mozversion platform_changeset: 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 12:46:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:46:10 INFO - mozversion platform_version: 49.0a1 12:46:10 INFO - using testdate: 1461699970 12:46:10 INFO - actual date: 1461699970 12:46:10 INFO - starting webserver on 'localhost:36700' 12:46:10 INFO - SUITE-START | Running 2 tests 12:46:10 INFO - TEST-START | dromaeo_css 12:46:10 INFO - operating with platform_type : linux_ 12:46:10 INFO - Initialising browser for dromaeo_css test... 12:46:10 INFO - TEST-INFO | started process 22962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3vaqzw/profile http://localhost:36700/getInfo.html) 12:46:13 INFO - PROCESS | 22962 | 12:46:13 INFO - PROCESS | 22962 | (process:23030): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:46:14 INFO - PROCESS | 22962 | __metrics Screen width/height:1600/1200 12:46:14 INFO - PROCESS | 22962 | colorDepth:24 12:46:14 INFO - PROCESS | 22962 | Browser inner width/height: 1024/697 12:46:14 INFO - PROCESS | 22962 | __metrics 12:46:15 ERROR - PROCESS | 22962 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:46:15 INFO - TEST-INFO | 22962: exit 0 12:46:15 INFO - Browser initialized. 12:46:15 INFO - Running cycle 1/1 for dromaeo_css test... 12:46:15 INFO - TEST-INFO | started process 23081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3vaqzw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:46:18 INFO - PROCESS | 23081 | 12:46:18 INFO - PROCESS | 23081 | (process:23139): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:46:28 INFO - PROCESS | 23081 | RSS: Main: 166031360 12:46:28 INFO - PROCESS | 23081 | 12:47:17 INFO - PROCESS | 23081 | 1461700037612 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] 12:49:28 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36700/tests/dromaeo/cssquery-ext.html) 12:49:29 INFO - PROCESS | 23081 | RSS: Main: 170532864 12:49:29 INFO - PROCESS | 23081 | 12:52:31 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-ext.html (next: http://localhost:36700/tests/dromaeo/cssquery-jquery.html) 12:52:32 INFO - PROCESS | 23081 | RSS: Main: 166846464 12:52:32 INFO - PROCESS | 23081 | 12:55:34 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36700/tests/dromaeo/cssquery-mootools.html) 12:55:35 INFO - PROCESS | 23081 | RSS: Main: 167948288 12:55:35 INFO - PROCESS | 23081 | 12:58:36 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36700/tests/dromaeo/cssquery-prototype.html) 12:58:37 INFO - PROCESS | 23081 | RSS: Main: 165412864 12:58:37 INFO - PROCESS | 23081 | 13:01:40 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36700/tests/dromaeo/cssquery-yui.html) 13:01:40 INFO - PROCESS | 23081 | RSS: Main: 167145472 13:01:40 INFO - PROCESS | 23081 | 13:04:43 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:36700/tests/dromaeo/cssquery-yui.html (next: http://localhost:36700/tests/dromaeo/cssquery-dojo.html) 13:04:43 INFO - PROCESS | 23081 | RSS: Main: 169070592 13:04:43 INFO - PROCESS | 23081 | 13:04:43 INFO - PROCESS | 23081 | __start_tp_report 13:04:43 INFO - PROCESS | 23081 | _x_x_mozilla_page_load 13:04:43 INFO - PROCESS | 23081 | _x_x_mozilla_page_load_details 13:04:43 INFO - PROCESS | 23081 | |i|pagename|runs| 13:04:43 INFO - PROCESS | 23081 | |0;dojo.html;2575.240304110287;2645.034562384729;2676.357674158203;2680.664916885389;2691.7577418032374;4578.221702310611;4600.286955521891;4614.700044497105;4618.030213655133;4676.883077923054;4539.228331183698;4591.5867571918525;4623.722576645395;4679.766011699418;4712.434507859061;4198.811053502584;4280.700350975433;4280.721753086055;4291.828326866922;4332.458442694663;641.4048391369478;4126;4229.090745489719;4262.808173632194;4313.611774940255;4276.866630342962;4279.358096285551;4282.571742825692;4304.677149213821;4327.632151267146;4228.809703563347;4298.591633794785;4302.247106756305;4329.112531930978;4350.543192964757;4154.293770059067;4207.368894665825;4259.74441533509;4286.657067434598;4298.333758267474;4512.932306015412;4562.315652652095;4563.885902852422;4577.450705915311;4609.631229501665;4778.976105119487;4955.677880937727;4956.727379994099;4965.280034395028;4965.3048573199785;4849.175640141185;4880.951190488086;4901.534354236342;4921.360223170965;4925.507449255082;4623.283391074388;4666.60333871618;4669.066186762661;4673.182193116157;4710.293455981596;4904.754762261872;4963.429205641398;5049.065922804293;5083.364579427572;5117.232415137759;4842.128416884994;4847.587955023792;4873.585745211697;4892.143874821892;4898.14282500561;4943.134951383494;4943.233798761198;4947.084789313988;4949.059678661043;4986.925196122061;4752.95247047532;4788.209945358977;4890.209132570021;4913.557779799835;4946.530079642428;4845.418549773979;4870.634702397334;4908.01839632075;4909.214525675875;4922.729249891218;4243.978780106079;4252.808623611945;4263.296556068276;4273;4284.485861696554;3693.1874987502706;3714.3685573452576;3746.157114649182;3772.660460558563;3797.18360552477;4212.178625168124;4279.550647182064;4323.178596066738;4372.890677733082;4374.431323927869;4921.50784921505;4936.753162341868;4940.555350018516;4941.110600092018;4980.352554167935;4200.22295875258;4279.850205242801;4324.589164029412;4352.107817897323;4362.323839804835;4456.75487848165;4465.1962646723905;4465.531119232499;4472.418585583853;4481.663875209372;4573.679842411066;4611.608013318905;4623.630109591225;4627.8611641650805;4667.183242932541;4975.651704380659;4994.1759609663995;5022.648414610942;5032.270320803536;5055.368078990126;4670.766461676971;4684.882877928079;4690.648201384842;4696.553827386393;4721.409823772028;4795.664303498722;4816.975915120402;4876.95123048765;4916.606671466346;4958.950410495849;4915.311856340187;4936.234883593049;4962.156433406401;4963.156263435152;5000.699958002531;4787.808487660454;4804.183288840975;4828.686135401328;4832.830850920342;4866.878328041827;4677.742724150068;4749.976250118727;4781.545753153445;4833.564979151894;4854.878628034327;4698.953010469988;4711.1519926413575;4716.056788642217;4729.054189162112;4739.549742774431;4852.078105160008;4856.757162141949;4858.732769697701;4862.7325497098;4913.287573301923;4663.300504924288;4684.6486513510945;4754.595859351994;4782.019685964438;4814.350062741625 13:04:43 INFO - PROCESS | 23081 | |1;ext.html;565.9915101273482;585.4409039367405;611.3366996808462;629.2574761781098;637.5473413876148;28610.28474288144;29345.266368340803;29765.70234297662;29771;29833.1050068498;29864.850675746646;30262.243443913914;30322.393552128946;30561.847190764016;30629.846850765716;7301.707931682739;7432.368248698867;7456.328930396263;7461.813454663623;7463.738769143081;7260.419166466696;7556.962215188916;7572.621368931559;7579.1662917079075;7601.923980760204;7519.586422746746;7606.885896711554;7607.771766846976;7614.276643718866;7626.19924907885;7533.510321829091;7534.133574638932;7540.886886696704;7599.392048636151;7619;7432.814179645498;7468.626568671545;7501.737439189602;7519.323260906544;7522.984397106376;23505.529889402118;28808;29387.412251754846;29534.852325738448;29567.260818479495;2759.6412466379243;2819.760320372771;3034.0746072447896;3215.389076075538;3480.112571294329;23024;23584;24192.395190120213;24797.62803557948;25738.87130564335;3403.268297316064;3427;3453.8791142309897;3573.231755172624;3616.385214513539;188106.05946970315;188151;188887.05556472266;189299;190131;27576.448471030868;39391.40912886309;39395;39717.80141099276;39729.60270397317;27168.147344528934;27171.320716982234;27221;27260.59109113365;27268.72731272662;12269.938650306869;12331.6917077072;12338.259704417764;12351.93824030892;12358.320292384005;10345.844812327821;10402.47987600617;10460.947695261475;10462.581496740046;10465.058144767008;6786.185657721105;6850.862982740417;7155.570665760071;7244.840825468005;7301.452391070585;2892.6528816541727;2951.3654564268354;2980.269833890667;3048.039867441793;3061.2040869374123;791.7901756034655;803.2529747335035;843.700486327345;854.4531499840107;915.8534634458455;24356.903939322772;25148.24555263345;25180.622290665655;25371.746282537308;25386.1114860979;881.7663319220412;904.3488688144525;955.1165172215673;962.4465932089076;968.2931460034215;12849.550265740654;13207.339633018311;13285.468581256835;13325.067245292736;13364.2649654268;264330;265640;267956;268300;269035;38053.23893522169;38782.612173878464;38836;38917.22165556729;38985.80507097503;1078.8058149533003;1088.1349327284827;1091.2470395427288;1104.304288298383;1188.3761025461529;23336.533269334857;23837.523249534566;24338;24517.38706532351;24521.87739061293;33202.5019624701;34381.82809085939;34402.82798585991;34425.48361774525;37038.62961370352;203335;203534;205041;205341;206433;32311;32647.510287345234;32690.836545817117;32832.50751238686;32875.67124328822;33616.15959601029;34034;34318.828405857814;34384.312313753086;34492.13769655779;30463.695363046085;30713.539296910116;30795.384092318476;31327.373452530366;31432.52851207188;29737;29840.70159298466;29995.850020749756;30132.84933575318;30569;24538.509229814947;33225.16937076592;33268.833655831564;33503.83248083744;34432.139196520286;29444.70555294505;30294;30719.539206912363;32163.35673286568;33766.831165844014;26570.734292656827;26700;26833.177043795924;26834.731652683222;26852.731472685806 13:04:43 INFO - PROCESS | 23081 | |2;jquery.html;346.34540718042905;354.12354422803554;362.77145398399006;366.34972923061565;369.6211383332084;13931.876275586024;14368.784468232985;14822.925885370558;14870.033447825885;14874;11266.324020558772;12935.223886566813;13475;13771.104878182936;13887;4887.6089912807065;4951.925721114186;5043.974780126113;5096.974515127419;5119.360079990001;4918.385201849769;4935.111679897617;4948.901021979576;4949.307097006422;4972.602191824645;4769.761511924407;4918.581920536759;4926.852194434155;4931.827386041489;4939.481354457784;5077.314562534085;5109.948900511003;5112.156494178456;5116.616253780981;5117.692938423688;4417.602415782563;4567.040921406476;4601.700889442175;4609.67732258742;4619.099275641252;17461;17478.126093695264;17506.47480575572;17588.91205543964;17631.911840440716;1728.8962662240306;1825.3976187858107;1899.5536049028467;2018.2431588154443;2026.5946810637784;8473.322134229247;8590.69932552364;8619.525926074064;8643.740687779376;8746.475211487332;1763.180121243615;1847.8706490545667;1876.1651065275958;1879.144989029988;1901.1729897494633;53722.194167087524;57893;58928.41071589229;59416.70291648514;59887;9193.264538836876;9502.192313653279;9508.239340852715;9616.374935629161;9769.51152442375;13114.540991065267;13143.737125257441;13166.605001849959;13195.67010824737;13215.537456188988;6662.167229096363;6809.080774095532;6971.093757811554;6981.301869812978;6999.790006299819;6329.68351582419;6371.39471750183;6403.967980160162;6483.351664833479;6538.542302038812;4133.772642504691;4180.435641188401;4183.748975061506;4189.7695626740215;4307.461567304087;1769.3364988129451;1784.2238626197645;1793.5336812428602;1796.4880009197316;1823.680855850221;762.4967521435826;764.2472164917551;836.7949852286229;861.4572819123912;890.1054440287598;14337.06809057408;14754.188519631309;14796.408143674347;14966.850331496764;15167.165805880783;805.472415567804;831.5468069901918;862.9266512346395;891.197921870309;897.9191872731485;8225.79435514105;8589;8615.827683446296;8660.350473714496;8979.640814367483;290079;295141;297503;297677;358819;46021.30968035482;55379.89240215173;57799.711001444724;68048.65975670189;75072.24927750653;947.5309721687809;988.6786794291884;997.8503224516236;1004.0210794475474;1009.5557954499997;14420.927895360455;14435.78346324827;14573.854261457249;14587.489437870048;14744.262786860829;32963.50554741633;33027.66972330342;33408.83295583507;33521.66478335185;34216.315673686884;45713.31430028619;46209.53790462052;46281.53718462907;46307.76846115748;46337.768311159576;6991.475639327173;7067.293270672892;7088.822779430556;7256.89114663291;7323;9417.811643767223;11086.279391839505;11141.442927853737;11306.095512359156;11420.48607812667;9935.751606209613;10112.59549618007;10168.28821982454;10193.184545236216;10388.896111038794;9571.712848614552;9724.902750972682;9855.11303982645;9870.901290987285;10009.349392289478;10116.544755486168;10121.291509594257;10145.9492702536;10368.429736364573;10403.167746580406;6931.480138989495;7343.70625174987;7551.207123252199;7611.467197296136;7663.348615367756;9690.37012594179;10237.23220758461;10266.538005789907;10374.481275936323;10584.788304234025 13:04:43 INFO - PROCESS | 23081 | |3;mootools.html;1292.2892409174951;1325.5095614622592;1342.9328533573325;1567.521905818725;1588.261458421835;6438.935610643904;7114.64426778661;7305.890411643816;7312.817179570513;7379.667914943827;7350.669219885104;7446.553206807582;7454.254574542543;7456.850862982737;7468.327850493454;2181.0730439563163;2221.7000704904794;2226.2430773536994;2248.932532024042;2251.482159103399;2169.566086782642;2179.302623160589;2219.6337604295272;2220.0897631970897;2220.289507357646;2182.127149140341;2204.184451752854;2211.6903633491324;2222.533268013719;2253.504229069602;2151.623465893478;2163.2969284982364;2165.7292838395124;2166.664167054109;2175.1734340950497;2107.136074209582;2133.136079887648;2146.5063035501767;2147.9355619331445;2148.495103650641;7566.205548417447;7578.128515220765;7587.393008559302;7613.923860761377;7616.04799400075;4380.693351465398;4571.977140114312;4578.038611891507;4578.175928332898;4582.381378513925;2833.9858300708365;2904.390078083584;2957.526795712697;2974.2415684000657;2985.1044686593937;911.0661571888801;915.6749353979375;923.9214666753334;924.4869097650801;932.4172392254841;10487.79024419515;10500.159987201005;10534.525946332433;10569.41868197249;10580.682579522627;4145.626893579532;4285.442892423965;4291.270484017725;4331.5884990925815;4334.41485399467;8897.021327653953;8915.955420222987;8963;8995.55022248898;9009.504477253682;4544.045750392388;4629.814807407666;4657.813687452532;4667.089917466062;4668.603168730696;3421.657834216608;4054.7567145971334;4092.7544347338658;4207.852725154605;4208.810603522848;3431.5367425397253;3442.9655703442645;3472.652734726558;3574.195805943694;3598.838052287653;1163.6101905861462;1191.8152686333633;1192.5904612606541;1205.7889869272842;1207.0404028797127;710.9857802844018;721.0482163544071;751.3838652305058;757.4394947738633;758.7078974594821;5158.0199762045095;5162.793488260502;5196.76614552346;5201;5324.547413469821;400.9097952960561;405.60453557780926;405.73424407013454;405.8924385037967;409.76643313311126;3573.94639080414;3609.115766637138;3615.7649752765988;3676.558812942464;3691.963080369162;9347.953260233655;9476.384035037701;9658.034196580285;9704.466254356079;9746.366486178376;9514.904850951401;9523.190528804991;9580.95209523948;9651.71044868655;9658.613655453702;7113.53762005468;7115.395191408788;7239.638018099179;7309.634518274065;7392.778216653509;5217.452167522356;5231.163013917755;5234.869128271824;5322.09524380864;5429.158480435539;8796.956015219883;8917.152870477294;8955.104489550993;8962.417442866194;9000.774980625536;8910.86633700482;9072.228860546928;9109.544522773702;9252;9263.722088337361;6654.534182607171;6692.765753198614;6714.227863795726;6757.45940324763;6769.018492318488;7226.168990566152;7249.963750181215;7259.9274007259255;7285.052943117361;7308.30571095745;6561.737530498726;6762.729490820312;6811.69347379379;6919.550229235084;6937.340952609494;6492.188476440445;6595.340465953366;6665.200175978914;6723.5293529452465;6740.090087838079;6046.758129674764;6055.878882422415;6100.1459795629535;6152.538559607958;6193.597416167935;4169.478815148106;4257.233697934278;4258.957410425856;4327.134573085333;4393.7363758174615;4411.18393097278;4486.7083639563325;4527.4340707411575;4533.750643714628;4582.143177045408 13:04:43 INFO - PROCESS | 23081 | |4;prototype.html;298.39574860906663;299.91602351341623;301.38367039404415;303.78886673761735;304.80949406620863;4776.164171270027;4876.292937524061;4918.827841025569;4928.679635823669;4972.2541618757205;4843.975780121094;4868.245421959593;4894.119058569456;4899.848535594133;4931.1617025105725;3665.6700896919274;3741.850325986971;3873.7288389812725;3880.4373365861934;3913.9021524461905;3865.4588357629955;3869.9032524186837;3876.8255428505645;3878.495795546575;3889.747166434173;3826.4834247376666;3830.942535861964;3831.8275677594575;3851.6504931991462;3864.420336949452;3778.357679194516;3812.942805857914;3859.36320507116;3860.417228936137;3876.8643097491595;3402.2004828865197;3404.8467818948207;3409.6078950920464;3416.24842534642;3439.398105331582;4715.976420117911;4724.622030237572;4750.548697873696;4763.214069678499;4774.140654682155;4349.347597860315;4402.339649052636;4402.581754733295;4403.141387429452;4431.711938723973;4864.318995340655;5144.356955380577;5157.922631160535;5161.4322424533275;5180.430152683201;3631.364511210528;3637.654422829827;3657.8353974070965;3673.651003154696;3677.3380791457525;5337.199420086979;5447.536959358459;5452.945470545284;5457.345118585756;5460.426655201226;3520.9119772005392;3727.1800203955086;3743.21392507571;3762.811859407019;3783.2244389900557;3787.16682329887;3790.7156963227317;3805.904852378713;3811.2187001664593;3822.3884178531302;4335.588119128678;4342.458427258341;4353.499347575006;4354.303311470149;4378.6278166356215;4907.975460122677;5173.663711858717;5186.5850731941355;5203.453637368098;5206.817761378334;1351.2973253907912;1354.8983826213073;1361.46902707944;1362.6320893358738;1364.3451143451;880.4365206267994;907.8138981508774;925.6898938855425;938.4275591888942;940.9623615055322;4346.6522678185665;4437;4538.29656403258;4598.172328980749;4616.8614941551805;5339.546138578265;5353.330833645794;5366.543843773245;5377.3816011159215;5378.381486129067;4553.590176884097;4567.10941366437;4594.310853372021;4606.723596584216;4629.236176030984;2926.443975644621;3066.739327157217;3068.324968506925;3073.1548824073557;3077.415291094685;5391.7034563099405;5431.864203394946;5434.858679677233;5437;5457.372402173801;5244.921326180111;5487.314085739283;5833.883322333614;5885.411458854081;5907.70461476933;5060.190369540929;5083.364579427572;5094.6819197265895;5098.668586541937;5110.616703747234;5392.487713667196;5393.568514518907;5401.4868587484125;5407.486288802557;5412.458754124556;5185.714785686823;5272.815451459181;5279.656822306538;5296.920546191733;5315.415304316445;5034.597232221487;5034.874128146826;5075.162598171408;5089.338386009943;5090.338256026693;3832;3891.124496988155;3892.9805350973065;3897.785621790829;3922.941155882607;5132.384113906355;5186.299849520417;5308.309919710413;5311.309529761106;5388.299521062237;5167.844964651066;5171.6553696040055;5173.896522069463;5176.534111929945;5204.2193670948145;5118.820841270538;5119.820806271762;5141.87145321355;5149.562287205629;5169.974150129226;4755.690880092783;5104.591632669451;5145.974270128625;5160.225966105114;5176.663516871391;5001.674221487026;5046.1673823818655;5200.765965531485;5212.791488340424;5225.790968361223;5048.91448338609;5052.393712754493;5096.992774263203;5104.285400044071;5128.461511541234 13:04:43 INFO - PROCESS | 23081 | |5;yui.html;564.4271064869158;590.8759160576279;603.7998607380881;640.7372977079399;662.8508585568247;11779.23434976726;11932.1647484676;12198.14612977092;12267.877321226784;12447.813282800766;10886;10924.344539327645;10962.945185274062;10985.780284394308;11009.559617615285;506.6681323732961;508.3340823521199;525.2305372629097;528.6537318056679;546.3307448375728;528.6220352447999;529.2933933199183;531.2960327565971;534.6391185949468;536.4903341825262;549.5191707256151;551.4265164229217;552.3923683947665;556.7717235933268;556.9443055694438;684.2029036172853;689.434663575868;696.9128858892639;700.9228984811666;706.2443185791205;407.1490584678007;409.3430044778118;411.3315861724697;411.9361498967665;412.581230051498;10896.564137434492;10984;11007.339559626447;11055.502502387411;11057.281276717069;11132.610358637408;11344.43277836105;11351.262167959056;11435.085193184608;11695.824562631567;9624.236171732386;9672.129508344213;9788.363756355815;9834.508274586242;9854.359466634645;3305.685959833812;3323.9833800830843;3344.8494817733263;3359.9496007559906;3451.8263790311416;42128.645068107864;42313.78843105765;42349.57650423487;42546.57453425488;44148.77925610384;9654.806903862023;9849.55676994537;9864.556094975744;9876.555555000043;9936.056074672895;15132.470363537223;15159.393624254906;15742.763858542132;16042;16059.277332520065;6142.662153581596;6223.564350495421;6313.55805093639;6329.272133704683;6427.421532062137;3549.290141971616;3645.8906232813056;3655.3420384331075;3736.7757934524016;3754.3992961126087;2513.170653684316;2573.7297583753434;2576.6135079737815;2831.292176955761;2955.423692380008;508.47118996244234;510.39008384979593;516.4938360406748;528.4240178205774;537.3820106877045;576.0127559918299;577.5206578539802;588.6144575303098;589.0898561722149;597.0387675841891;7697.461177717506;7884;7971.322437592754;8120.959395202986;8192.057913339922;547.5400663442648;548.3529435266424;588.109014842514;593.4718100890211;618.8886000519859;3567.4113771227458;3707.295613833363;3773.113318370181;3917.5690674025836;3922.4312474691583;45664;49115;50303.496965030616;50346.49653503418;50477.24284135741;42126.578734212875;42489.36265956013;46064.309035364495;46641.83395415074;46927.53072469232;42132.57867421348;42314.57685423168;42346.576534234264;42873;42932.570674293485;7497.700091996478;7814.609269536387;7825.491343062683;7858.528488290721;7868.488548244346;28481.43037139204;29392.853035734686;29682.703172967995;29786.255343616584;30238.84880575583;35925;37393.6260637401;37496.437553436175;38019.42970855384;38098.23803523859;9538.713838584854;9608.423494590346;9702.369345992487;10118.568432769682;10318.896811031793;11189.160812939224;11251.493682784458;11399.487023083815;11604.897534734188;11672.533098676298;9598.472084035446;9631.855522167032;9654.275929305471;10034.849477257701;10910.399928004035;9809.852852207365;9869.309148359545;10033.247506437192;10049.246306527186;10416.479176041319;10369.9481502592;10477.580896764044;10578.947105264424;10654.680359589225;10747.301425407324;9323.487208203615;9451.527423628928;9565.378250413702;9603.855942160733;9816.950915245377;9016.143466370684;9234.538273086184;9281.67514137002;9331.58007889633;9394.201492873182 13:04:43 INFO - PROCESS | 23081 | __end_tp_report 13:04:43 INFO - PROCESS | 23081 | __start_cc_report 13:04:43 INFO - PROCESS | 23081 | _x_x_mozilla_cycle_collect,377 13:04:43 INFO - PROCESS | 23081 | __end_cc_report 13:04:43 INFO - PROCESS | 23081 | __startTimestamp1461701083510__endTimestamp 13:04:43 INFO - PROCESS | 23081 | 13:04:43 INFO - PROCESS | 23081 | ------- Summary: start ------- 13:04:43 INFO - PROCESS | 23081 | Number of tests: 6 13:04:43 INFO - PROCESS | 23081 | 13:04:43 INFO - PROCESS | 23081 | [#0] dojo.html Cycles:165 Average:4554.77 Median:4690.65 stddev:549.17 (11.7%) stddev-sans-first:528.44 13:04:43 INFO - PROCESS | 23081 | Values: 2575.2 2645.0 2676.4 2680.7 2691.8 4578.2 4600.3 4614.7 4618.0 4676.9 4539.2 4591.6 4623.7 4679.8 4712.4 4198.8 4280.7 4280.7 4291.8 4332.5 641.4 4126.0 4229.1 4262.8 4313.6 4276.9 4279.4 4282.6 4304.7 4327.6 4228.8 4298.6 4302.2 4329.1 4350.5 4154.3 4207.4 4259.7 4286.7 4298.3 4512.9 4562.3 4563.9 4577.5 4609.6 4779.0 4955.7 4956.7 4965.3 4965.3 4849.2 4881.0 4901.5 4921.4 4925.5 4623.3 4666.6 4669.1 4673.2 4710.3 4904.8 4963.4 5049.1 5083.4 5117.2 4842.1 4847.6 4873.6 4892.1 4898.1 4943.1 4943.2 4947.1 4949.1 4986.9 4753.0 4788.2 4890.2 4913.6 4946.5 4845.4 4870.6 4908.0 4909.2 4922.7 4244.0 4252.8 4263.3 4273.0 4284.5 3693.2 3714.4 3746.2 3772.7 3797.2 4212.2 4279.6 4323.2 4372.9 4374.4 4921.5 4936.8 4940.6 4941.1 4980.4 4200.2 4279.9 4324.6 4352.1 4362.3 4456.8 4465.2 4465.5 4472.4 4481.7 4573.7 4611.6 4623.6 4627.9 4667.2 4975.7 4994.2 5022.6 5032.3 5055.4 4670.8 4684.9 4690.6 4696.6 4721.4 4795.7 4817.0 4877.0 4916.6 4959.0 4915.3 4936.2 4962.2 4963.2 5000.7 4787.8 4804.2 4828.7 4832.8 4866.9 4677.7 4750.0 4781.5 4833.6 4854.9 4699.0 4711.2 4716.1 4729.1 4739.5 4852.1 4856.8 4858.7 4862.7 4913.3 4663.3 4684.6 4754.6 4782.0 4814.4 13:04:43 INFO - PROCESS | 23081 | 13:04:43 INFO - PROCESS | 23081 | [#1] ext.html Cycles:180 Average:35312.09 Median:16815.10 stddev:58111.13 (345.6%) stddev-sans-first:58215.59 13:04:43 INFO - PROCESS | 23081 | Values: 566.0 585.4 611.3 629.3 637.5 28610.3 29345.3 29765.7 29771.0 29833.1 29864.9 30262.2 30322.4 30561.8 30629.8 7301.7 7432.4 7456.3 7461.8 7463.7 7260.4 7557.0 7572.6 7579.2 7601.9 7519.6 7606.9 7607.8 7614.3 7626.2 7533.5 7534.1 7540.9 7599.4 7619.0 7432.8 7468.6 7501.7 7519.3 7523.0 23505.5 28808.0 29387.4 29534.9 29567.3 2759.6 2819.8 3034.1 3215.4 3480.1 23024.0 23584.0 24192.4 24797.6 25738.9 3403.3 3427.0 3453.9 3573.2 3616.4 188106.1 188151.0 188887.1 189299.0 190131.0 27576.4 39391.4 39395.0 39717.8 39729.6 27168.1 27171.3 27221.0 27260.6 27268.7 12269.9 12331.7 12338.3 12351.9 12358.3 10345.8 10402.5 10460.9 10462.6 10465.1 6786.2 6850.9 7155.6 7244.8 7301.5 2892.7 2951.4 2980.3 3048.0 3061.2 791.8 803.3 843.7 854.5 915.9 24356.9 25148.2 25180.6 25371.7 25386.1 881.8 904.3 955.1 962.4 968.3 12849.6 13207.3 13285.5 13325.1 13364.3 264330.0 265640.0 267956.0 268300.0 269035.0 38053.2 38782.6 38836.0 38917.2 38985.8 1078.8 1088.1 1091.2 1104.3 1188.4 23336.5 23837.5 24338.0 24517.4 24521.9 33202.5 34381.8 34402.8 34425.5 37038.6 203335.0 203534.0 205041.0 205341.0 206433.0 32311.0 32647.5 32690.8 32832.5 32875.7 33616.2 34034.0 34318.8 34384.3 34492.1 30463.7 30713.5 30795.4 31327.4 31432.5 29737.0 29840.7 29995.9 30132.8 30569.0 24538.5 33225.2 33268.8 33503.8 34432.1 29444.7 30294.0 30719.5 32163.4 33766.8 26570.7 26700.0 26833.2 26834.7 26852.7 13:04:43 INFO - PROCESS | 23081 | 13:04:43 INFO - PROCESS | 23081 | [#2] jquery.html Cycles:180 Average:20466.83 Median:4614.39 stddev:51003.00 (1105.3%) stddev-sans-first:51123.70 13:04:43 INFO - PROCESS | 23081 | Values: 346.3 354.1 362.8 366.3 369.6 13931.9 14368.8 14822.9 14870.0 14874.0 11266.3 12935.2 13475.0 13771.1 13887.0 4887.6 4951.9 5044.0 5097.0 5119.4 4918.4 4935.1 4948.9 4949.3 4972.6 4769.8 4918.6 4926.9 4931.8 4939.5 5077.3 5109.9 5112.2 5116.6 5117.7 4417.6 4567.0 4601.7 4609.7 4619.1 17461.0 17478.1 17506.5 17588.9 17631.9 1728.9 1825.4 1899.6 2018.2 2026.6 8473.3 8590.7 8619.5 8643.7 8746.5 1763.2 1847.9 1876.2 1879.1 1901.2 53722.2 57893.0 58928.4 59416.7 59887.0 9193.3 9502.2 9508.2 9616.4 9769.5 13114.5 13143.7 13166.6 13195.7 13215.5 6662.2 6809.1 6971.1 6981.3 6999.8 6329.7 6371.4 6404.0 6483.4 6538.5 4133.8 4180.4 4183.7 4189.8 4307.5 1769.3 1784.2 1793.5 1796.5 1823.7 762.5 764.2 836.8 861.5 890.1 14337.1 14754.2 14796.4 14966.9 15167.2 805.5 831.5 862.9 891.2 897.9 8225.8 8589.0 8615.8 8660.4 8979.6 290079.0 295141.0 297503.0 297677.0 358819.0 46021.3 55379.9 57799.7 68048.7 75072.2 947.5 988.7 997.9 1004.0 1009.6 14420.9 14435.8 14573.9 14587.5 14744.3 32963.5 33027.7 33408.8 33521.7 34216.3 45713.3 46209.5 46281.5 46307.8 46337.8 6991.5 7067.3 7088.8 7256.9 7323.0 9417.8 11086.3 11141.4 11306.1 11420.5 9935.8 10112.6 10168.3 10193.2 10388.9 9571.7 9724.9 9855.1 9870.9 10009.3 10116.5 10121.3 10145.9 10368.4 10403.2 6931.5 7343.7 7551.2 7611.5 7663.3 9690.4 10237.2 10266.5 10374.5 10584.8 13:04:43 INFO - PROCESS | 23081 | 13:04:43 INFO - PROCESS | 23081 | [#3] mootools.html Cycles:180 Average:5056.81 Median:5160.41 stddev:2856.94 (55.4%) stddev-sans-first:2850.95 13:04:43 INFO - PROCESS | 23081 | Values: 1292.3 1325.5 1342.9 1567.5 1588.3 6438.9 7114.6 7305.9 7312.8 7379.7 7350.7 7446.6 7454.3 7456.9 7468.3 2181.1 2221.7 2226.2 2248.9 2251.5 2169.6 2179.3 2219.6 2220.1 2220.3 2182.1 2204.2 2211.7 2222.5 2253.5 2151.6 2163.3 2165.7 2166.7 2175.2 2107.1 2133.1 2146.5 2147.9 2148.5 7566.2 7578.1 7587.4 7613.9 7616.0 4380.7 4572.0 4578.0 4578.2 4582.4 2834.0 2904.4 2957.5 2974.2 2985.1 911.1 915.7 923.9 924.5 932.4 10487.8 10500.2 10534.5 10569.4 10580.7 4145.6 4285.4 4291.3 4331.6 4334.4 8897.0 8916.0 8963.0 8995.6 9009.5 4544.0 4629.8 4657.8 4667.1 4668.6 3421.7 4054.8 4092.8 4207.9 4208.8 3431.5 3443.0 3472.7 3574.2 3598.8 1163.6 1191.8 1192.6 1205.8 1207.0 711.0 721.0 751.4 757.4 758.7 5158.0 5162.8 5196.8 5201.0 5324.5 400.9 405.6 405.7 405.9 409.8 3573.9 3609.1 3615.8 3676.6 3692.0 9348.0 9476.4 9658.0 9704.5 9746.4 9514.9 9523.2 9581.0 9651.7 9658.6 7113.5 7115.4 7239.6 7309.6 7392.8 5217.5 5231.2 5234.9 5322.1 5429.2 8797.0 8917.2 8955.1 8962.4 9000.8 8910.9 9072.2 9109.5 9252.0 9263.7 6654.5 6692.8 6714.2 6757.5 6769.0 7226.2 7250.0 7259.9 7285.1 7308.3 6561.7 6762.7 6811.7 6919.6 6937.3 6492.2 6595.3 6665.2 6723.5 6740.1 6046.8 6055.9 6100.1 6152.5 6193.6 4169.5 4257.2 4259.0 4327.1 4393.7 4411.2 4486.7 4527.4 4533.8 4582.1 13:04:43 INFO - PROCESS | 23081 | 13:04:43 INFO - PROCESS | 23081 | [#4] prototype.html Cycles:180 Average:4324.23 Median:4885.21 stddev:1253.56 (25.7%) stddev-sans-first:1220.11 13:04:43 INFO - PROCESS | 23081 | Values: 298.4 299.9 301.4 303.8 304.8 4776.2 4876.3 4918.8 4928.7 4972.3 4844.0 4868.2 4894.1 4899.8 4931.2 3665.7 3741.9 3873.7 3880.4 3913.9 3865.5 3869.9 3876.8 3878.5 3889.7 3826.5 3830.9 3831.8 3851.7 3864.4 3778.4 3812.9 3859.4 3860.4 3876.9 3402.2 3404.8 3409.6 3416.2 3439.4 4716.0 4724.6 4750.5 4763.2 4774.1 4349.3 4402.3 4402.6 4403.1 4431.7 4864.3 5144.4 5157.9 5161.4 5180.4 3631.4 3637.7 3657.8 3673.7 3677.3 5337.2 5447.5 5452.9 5457.3 5460.4 3520.9 3727.2 3743.2 3762.8 3783.2 3787.2 3790.7 3805.9 3811.2 3822.4 4335.6 4342.5 4353.5 4354.3 4378.6 4908.0 5173.7 5186.6 5203.5 5206.8 1351.3 1354.9 1361.5 1362.6 1364.3 880.4 907.8 925.7 938.4 941.0 4346.7 4437.0 4538.3 4598.2 4616.9 5339.5 5353.3 5366.5 5377.4 5378.4 4553.6 4567.1 4594.3 4606.7 4629.2 2926.4 3066.7 3068.3 3073.2 3077.4 5391.7 5431.9 5434.9 5437.0 5457.4 5244.9 5487.3 5833.9 5885.4 5907.7 5060.2 5083.4 5094.7 5098.7 5110.6 5392.5 5393.6 5401.5 5407.5 5412.5 5185.7 5272.8 5279.7 5296.9 5315.4 5034.6 5034.9 5075.2 5089.3 5090.3 3832.0 3891.1 3893.0 3897.8 3922.9 5132.4 5186.3 5308.3 5311.3 5388.3 5167.8 5171.7 5173.9 5176.5 5204.2 5118.8 5119.8 5141.9 5149.6 5170.0 4755.7 5104.6 5146.0 5160.2 5176.7 5001.7 5046.2 5200.8 5212.8 5225.8 5048.9 5052.4 5097.0 5104.3 5128.5 13:04:43 INFO - PROCESS | 23081 | 13:04:43 INFO - PROCESS | 23081 | [#5] yui.html Cycles:180 Average:12167.54 Median:46353.07 stddev:13876.36 (29.9%) stddev-sans-first:13887.92 13:04:43 INFO - PROCESS | 23081 | Values: 564.4 590.9 603.8 640.7 662.9 11779.2 11932.2 12198.1 12267.9 12447.8 10886.0 10924.3 10962.9 10985.8 11009.6 506.7 508.3 525.2 528.7 546.3 528.6 529.3 531.3 534.6 536.5 549.5 551.4 552.4 556.8 556.9 684.2 689.4 696.9 700.9 706.2 407.1 409.3 411.3 411.9 412.6 10896.6 10984.0 11007.3 11055.5 11057.3 11132.6 11344.4 11351.3 11435.1 11695.8 9624.2 9672.1 9788.4 9834.5 9854.4 3305.7 3324.0 3344.8 3359.9 3451.8 42128.6 42313.8 42349.6 42546.6 44148.8 9654.8 9849.6 9864.6 9876.6 9936.1 15132.5 15159.4 15742.8 16042.0 16059.3 6142.7 6223.6 6313.6 6329.3 6427.4 3549.3 3645.9 3655.3 3736.8 3754.4 2513.2 2573.7 2576.6 2831.3 2955.4 508.5 510.4 516.5 528.4 537.4 576.0 577.5 588.6 589.1 597.0 7697.5 7884.0 7971.3 8121.0 8192.1 547.5 548.4 588.1 593.5 618.9 3567.4 3707.3 3773.1 3917.6 3922.4 45664.0 49115.0 50303.5 50346.5 50477.2 42126.6 42489.4 46064.3 46641.8 46927.5 42132.6 42314.6 42346.6 42873.0 42932.6 7497.7 7814.6 7825.5 7858.5 7868.5 28481.4 29392.9 29682.7 29786.3 30238.8 35925.0 37393.6 37496.4 38019.4 38098.2 9538.7 9608.4 9702.4 10118.6 10318.9 11189.2 11251.5 11399.5 11604.9 11672.5 9598.5 9631.9 9654.3 10034.8 10910.4 9809.9 9869.3 10033.2 10049.2 10416.5 10369.9 10477.6 10578.9 10654.7 10747.3 9323.5 9451.5 9565.4 9603.9 9817.0 9016.1 9234.5 9281.7 9331.6 9394.2 13:04:43 INFO - PROCESS | 23081 | -------- Summary: end -------- 13:04:43 INFO - PROCESS | 23081 | 13:04:44 INFO - TEST-INFO | 23081: exit 0 13:04:44 INFO - TEST-OK | dromaeo_css | took 1114174ms 13:04:44 INFO - TEST-START | kraken 13:04:44 INFO - operating with platform_type : linux_ 13:04:44 INFO - Initialising browser for kraken test... 13:04:44 INFO - TEST-INFO | started process 23313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzp7HxH/profile http://localhost:36700/getInfo.html) 13:04:47 INFO - PROCESS | 23313 | 13:04:47 INFO - PROCESS | 23313 | (process:23378): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:04:48 INFO - PROCESS | 23313 | __metrics Screen width/height:1600/1200 13:04:48 INFO - PROCESS | 23313 | colorDepth:24 13:04:48 INFO - PROCESS | 23313 | Browser inner width/height: 1024/697 13:04:48 INFO - PROCESS | 23313 | __metrics 13:04:49 ERROR - PROCESS | 23313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:04:50 INFO - TEST-INFO | 23313: exit 0 13:04:50 INFO - Browser initialized. 13:04:50 INFO - Running cycle 1/1 for kraken test... 13:04:50 INFO - TEST-INFO | started process 23429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzp7HxH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:52 INFO - PROCESS | 23429 | 13:04:52 INFO - PROCESS | 23429 | (process:23487): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:05:02 INFO - PROCESS | 23429 | RSS: Main: 165867520 13:05:02 INFO - PROCESS | 23429 | 13:05:04 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36700/tests/kraken/driver.html?testName=audio-beat-detection) 13:05:05 INFO - PROCESS | 23429 | RSS: Main: 169984000 13:05:05 INFO - PROCESS | 23429 | 13:05:08 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36700/tests/kraken/driver.html?testName=audio-dft) 13:05:09 INFO - PROCESS | 23429 | RSS: Main: 173572096 13:05:09 INFO - PROCESS | 23429 | 13:05:12 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36700/tests/kraken/driver.html?testName=audio-fft) 13:05:12 INFO - PROCESS | 23429 | RSS: Main: 166105088 13:05:12 INFO - PROCESS | 23429 | 13:05:14 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36700/tests/kraken/driver.html?testName=audio-oscillator) 13:05:15 INFO - PROCESS | 23429 | RSS: Main: 166494208 13:05:15 INFO - PROCESS | 23429 | 13:05:17 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36700/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:05:18 INFO - PROCESS | 23429 | RSS: Main: 166875136 13:05:18 INFO - PROCESS | 23429 | 13:05:21 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36700/tests/kraken/driver.html?testName=imaging-darkroom) 13:05:22 INFO - PROCESS | 23429 | RSS: Main: 167165952 13:05:22 INFO - PROCESS | 23429 | 13:05:25 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36700/tests/kraken/driver.html?testName=imaging-desaturate) 13:05:26 INFO - PROCESS | 23429 | RSS: Main: 164581376 13:05:26 INFO - PROCESS | 23429 | 13:05:29 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36700/tests/kraken/driver.html?testName=json-parse-financial) 13:05:29 INFO - PROCESS | 23429 | RSS: Main: 165048320 13:05:29 INFO - PROCESS | 23429 | 13:05:31 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36700/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:05:32 INFO - PROCESS | 23429 | RSS: Main: 165593088 13:05:32 INFO - PROCESS | 23429 | 13:05:34 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:05:34 INFO - PROCESS | 23429 | RSS: Main: 165380096 13:05:34 INFO - PROCESS | 23429 | 13:05:36 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:05:37 INFO - PROCESS | 23429 | RSS: Main: 166064128 13:05:37 INFO - PROCESS | 23429 | 13:05:40 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:05:41 INFO - PROCESS | 23429 | RSS: Main: 166813696 13:05:41 INFO - PROCESS | 23429 | 13:05:44 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:05:45 INFO - PROCESS | 23429 | RSS: Main: 163504128 13:05:45 INFO - PROCESS | 23429 | 13:05:46 INFO - PROCESS | 23429 | Cycle 1(1): loaded http://localhost:36700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36700/tests/kraken/driver.html?testName=ai-astar) 13:05:47 INFO - PROCESS | 23429 | RSS: Main: 165572608 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | __start_tp_report 13:05:47 INFO - PROCESS | 23429 | _x_x_mozilla_page_load 13:05:47 INFO - PROCESS | 23429 | _x_x_mozilla_page_load_details 13:05:47 INFO - PROCESS | 23429 | |i|pagename|runs| 13:05:47 INFO - PROCESS | 23429 | |0;ai-astar;114;108;113;113;116;126;116;113;114;116 13:05:47 INFO - PROCESS | 23429 | |1;audio-beat-detection;168;131;163;182;134;170;163;133;205;134 13:05:47 INFO - PROCESS | 23429 | |2;audio-dft;164;162;162;173;165;163;164;162;165;163 13:05:47 INFO - PROCESS | 23429 | |3;audio-fft;74;77;74;149;78;77;74;76;158;74 13:05:47 INFO - PROCESS | 23429 | |4;audio-oscillator;94;95;155;95;94;93;137;94;95;147 13:05:47 INFO - PROCESS | 23429 | |5;imaging-gaussian-blur;117;118;117;118;117;118;118;118;118;117 13:05:47 INFO - PROCESS | 23429 | |6;imaging-darkroom;146;147;148;147;146;147;148;148;147;147 13:05:47 INFO - PROCESS | 23429 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 13:05:47 INFO - PROCESS | 23429 | |8;json-parse-financial;67;67;73;66;66;66;69;93;64;65 13:05:47 INFO - PROCESS | 23429 | |9;json-stringify-tinderbox;64;64;65;66;64;64;65;63;65;69 13:05:47 INFO - PROCESS | 23429 | |10;stanford-crypto-aes;79;79;89;79;80;80;80;81;81;85 13:05:47 INFO - PROCESS | 23429 | |11;stanford-crypto-ccm;141;142;144;142;138;139;141;134;167;136 13:05:47 INFO - PROCESS | 23429 | |12;stanford-crypto-pbkdf2;221;226;217;222;222;217;213;219;226;217 13:05:47 INFO - PROCESS | 23429 | |13;stanford-crypto-sha256-iterative;81;78;77;76;74;77;75;75;78;76 13:05:47 INFO - PROCESS | 23429 | __end_tp_report 13:05:47 INFO - PROCESS | 23429 | __start_cc_report 13:05:47 INFO - PROCESS | 23429 | _x_x_mozilla_cycle_collect,932 13:05:47 INFO - PROCESS | 23429 | __end_cc_report 13:05:47 INFO - PROCESS | 23429 | __startTimestamp1461701147237__endTimestamp 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | ------- Summary: start ------- 13:05:47 INFO - PROCESS | 23429 | Number of tests: 14 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:4.56 (4.0%) stddev-sans-first:4.82 13:05:47 INFO - PROCESS | 23429 | Values: 114.0 108.0 113.0 113.0 116.0 126.0 116.0 113.0 114.0 116.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#1] audio-beat-detection Cycles:10 Average:158.30 Median:165.50 stddev:24.91 (15.1%) stddev-sans-first:26.17 13:05:47 INFO - PROCESS | 23429 | Values: 168.0 131.0 163.0 182.0 134.0 170.0 163.0 133.0 205.0 134.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:3.27 (2.0%) stddev-sans-first:3.46 13:05:47 INFO - PROCESS | 23429 | Values: 164.0 162.0 162.0 173.0 165.0 163.0 164.0 162.0 165.0 163.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#3] audio-fft Cycles:10 Average:91.10 Median:75.00 stddev:32.99 (44.0%) stddev-sans-first:34.41 13:05:47 INFO - PROCESS | 23429 | Values: 74.0 77.0 74.0 149.0 78.0 77.0 74.0 76.0 158.0 74.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:94.00 stddev:25.51 (27.1%) stddev-sans-first:26.40 13:05:47 INFO - PROCESS | 23429 | Values: 94.0 95.0 155.0 95.0 94.0 93.0 137.0 94.0 95.0 147.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:05:47 INFO - PROCESS | 23429 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 13:05:47 INFO - PROCESS | 23429 | Values: 146.0 147.0 148.0 147.0 146.0 147.0 148.0 148.0 147.0 147.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:05:47 INFO - PROCESS | 23429 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:67.00 stddev:8.59 (12.8%) stddev-sans-first:9.06 13:05:47 INFO - PROCESS | 23429 | Values: 67.0 67.0 73.0 66.0 66.0 66.0 69.0 93.0 64.0 65.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:1.66 (2.6%) stddev-sans-first:1.73 13:05:47 INFO - PROCESS | 23429 | Values: 64.0 64.0 65.0 66.0 64.0 64.0 65.0 63.0 65.0 69.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.50 stddev:3.23 (4.0%) stddev-sans-first:3.32 13:05:47 INFO - PROCESS | 23429 | Values: 79.0 79.0 89.0 79.0 80.0 80.0 80.0 81.0 81.0 85.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:141.50 stddev:9.16 (6.5%) stddev-sans-first:9.70 13:05:47 INFO - PROCESS | 23429 | Values: 141.0 142.0 144.0 142.0 138.0 139.0 141.0 134.0 167.0 136.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:220.00 Median:221.50 stddev:4.19 (1.9%) stddev-sans-first:4.43 13:05:47 INFO - PROCESS | 23429 | Values: 221.0 226.0 217.0 222.0 222.0 217.0 213.0 219.0 226.0 217.0 13:05:47 INFO - PROCESS | 23429 | 13:05:47 INFO - PROCESS | 23429 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:77.00 stddev:2.00 (2.6%) stddev-sans-first:1.39 13:05:47 INFO - PROCESS | 23429 | Values: 81.0 78.0 77.0 76.0 74.0 77.0 75.0 75.0 78.0 76.0 13:05:47 INFO - PROCESS | 23429 | -------- Summary: end -------- 13:05:47 INFO - PROCESS | 23429 | 13:05:48 INFO - TEST-INFO | 23429: exit 0 13:05:48 INFO - TEST-OK | kraken | took 64199ms 13:05:48 INFO - SUITE-END | took 1178s 13:05:48 INFO - Completed test suite (00:19:38) 13:05:48 INFO - javascript benchmark 13:05:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.240304110287, 2645.034562384729, 2676.357674158203, 2680.664916885389, 2691.7577418032374, 4578.221702310611, 4600.286955521891, 4614.700044497105, 4618.030213655133, 4676.883077923054, 4539.228331183698, 4591.5867571918525, 4623.722576645395, 4679.766011699418, 4712.434507859061, 4198.811053502584, 4280.700350975433, 4280.721753086055, 4291.828326866922, 4332.458442694663, 641.4048391369478, 4126.0, 4229.090745489719, 4262.808173632194, 4313.611774940255, 4276.866630342962, 4279.358096285551, 4282.571742825692, 4304.677149213821, 4327.632151267146, 4228.809703563347, 4298.591633794785, 4302.247106756305, 4329.112531930978, 4350.543192964757, 4154.293770059067, 4207.368894665825, 4259.74441533509, 4286.657067434598, 4298.333758267474, 4512.932306015412, 4562.315652652095, 4563.885902852422, 4577.450705915311, 4609.631229501665, 4778.976105119487, 4955.677880937727, 4956.727379994099, 4965.280034395028, 4965.3048573199785, 4849.175640141185, 4880.951190488086, 4901.534354236342, 4921.360223170965, 4925.507449255082, 4623.283391074388, 4666.60333871618, 4669.066186762661, 4673.182193116157, 4710.293455981596, 4904.754762261872, 4963.429205641398, 5049.065922804293, 5083.364579427572, 5117.232415137759, 4842.128416884994, 4847.587955023792, 4873.585745211697, 4892.143874821892, 4898.14282500561, 4943.134951383494, 4943.233798761198, 4947.084789313988, 4949.059678661043, 4986.925196122061, 4752.95247047532, 4788.209945358977, 4890.209132570021, 4913.557779799835, 4946.530079642428, 4845.418549773979, 4870.634702397334, 4908.01839632075, 4909.214525675875, 4922.729249891218, 4243.978780106079, 4252.808623611945, 4263.296556068276, 4273.0, 4284.485861696554, 3693.1874987502706, 3714.3685573452576, 3746.157114649182, 3772.660460558563, 3797.18360552477, 4212.178625168124, 4279.550647182064, 4323.178596066738, 4372.890677733082, 4374.431323927869, 4921.50784921505, 4936.753162341868, 4940.555350018516, 4941.110600092018, 4980.352554167935, 4200.22295875258, 4279.850205242801, 4324.589164029412, 4352.107817897323, 4362.323839804835, 4456.75487848165, 4465.1962646723905, 4465.531119232499, 4472.418585583853, 4481.663875209372, 4573.679842411066, 4611.608013318905, 4623.630109591225, 4627.8611641650805, 4667.183242932541, 4975.651704380659, 4994.1759609663995, 5022.648414610942, 5032.270320803536, 5055.368078990126, 4670.766461676971, 4684.882877928079, 4690.648201384842, 4696.553827386393, 4721.409823772028, 4795.664303498722, 4816.975915120402, 4876.95123048765, 4916.606671466346, 4958.950410495849, 4915.311856340187, 4936.234883593049, 4962.156433406401, 4963.156263435152, 5000.699958002531, 4787.808487660454, 4804.183288840975, 4828.686135401328, 4832.830850920342, 4866.878328041827, 4677.742724150068, 4749.976250118727, 4781.545753153445, 4833.564979151894, 4854.878628034327, 4698.953010469988, 4711.1519926413575, 4716.056788642217, 4729.054189162112, 4739.549742774431, 4852.078105160008, 4856.757162141949, 4858.732769697701, 4862.7325497098, 4913.287573301923, 4663.300504924288, 4684.6486513510945, 4754.595859351994, 4782.019685964438, 4814.350062741625], "value": 4523.4003467443445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9915101273482, 585.4409039367405, 611.3366996808462, 629.2574761781098, 637.5473413876148, 28610.28474288144, 29345.266368340803, 29765.70234297662, 29771.0, 29833.1050068498, 29864.850675746646, 30262.243443913914, 30322.393552128946, 30561.847190764016, 30629.846850765716, 7301.707931682739, 7432.368248698867, 7456.328930396263, 7461.813454663623, 7463.738769143081, 7260.419166466696, 7556.962215188916, 7572.621368931559, 7579.1662917079075, 7601.923980760204, 7519.586422746746, 7606.885896711554, 7607.771766846976, 7614.276643718866, 7626.19924907885, 7533.510321829091, 7534.133574638932, 7540.886886696704, 7599.392048636151, 7619.0, 7432.814179645498, 7468.626568671545, 7501.737439189602, 7519.323260906544, 7522.984397106376, 23505.529889402118, 28808.0, 29387.412251754846, 29534.852325738448, 29567.260818479495, 2759.6412466379243, 2819.760320372771, 3034.0746072447896, 3215.389076075538, 3480.112571294329, 23024.0, 23584.0, 24192.395190120213, 24797.62803557948, 25738.87130564335, 3403.268297316064, 3427.0, 3453.8791142309897, 3573.231755172624, 3616.385214513539, 188106.05946970315, 188151.0, 188887.05556472266, 189299.0, 190131.0, 27576.448471030868, 39391.40912886309, 39395.0, 39717.80141099276, 39729.60270397317, 27168.147344528934, 27171.320716982234, 27221.0, 27260.59109113365, 27268.72731272662, 12269.938650306869, 12331.6917077072, 12338.259704417764, 12351.93824030892, 12358.320292384005, 10345.844812327821, 10402.47987600617, 10460.947695261475, 10462.581496740046, 10465.058144767008, 6786.185657721105, 6850.862982740417, 7155.570665760071, 7244.840825468005, 7301.452391070585, 2892.6528816541727, 2951.3654564268354, 2980.269833890667, 3048.039867441793, 3061.2040869374123, 791.7901756034655, 803.2529747335035, 843.700486327345, 854.4531499840107, 915.8534634458455, 24356.903939322772, 25148.24555263345, 25180.622290665655, 25371.746282537308, 25386.1114860979, 881.7663319220412, 904.3488688144525, 955.1165172215673, 962.4465932089076, 968.2931460034215, 12849.550265740654, 13207.339633018311, 13285.468581256835, 13325.067245292736, 13364.2649654268, 264330.0, 265640.0, 267956.0, 268300.0, 269035.0, 38053.23893522169, 38782.612173878464, 38836.0, 38917.22165556729, 38985.80507097503, 1078.8058149533003, 1088.1349327284827, 1091.2470395427288, 1104.304288298383, 1188.3761025461529, 23336.533269334857, 23837.523249534566, 24338.0, 24517.38706532351, 24521.87739061293, 33202.5019624701, 34381.82809085939, 34402.82798585991, 34425.48361774525, 37038.62961370352, 203335.0, 203534.0, 205041.0, 205341.0, 206433.0, 32311.0, 32647.510287345234, 32690.836545817117, 32832.50751238686, 32875.67124328822, 33616.15959601029, 34034.0, 34318.828405857814, 34384.312313753086, 34492.13769655779, 30463.695363046085, 30713.539296910116, 30795.384092318476, 31327.373452530366, 31432.52851207188, 29737.0, 29840.70159298466, 29995.850020749756, 30132.84933575318, 30569.0, 24538.509229814947, 33225.16937076592, 33268.833655831564, 33503.83248083744, 34432.139196520286, 29444.70555294505, 30294.0, 30719.539206912363, 32163.35673286568, 33766.831165844014, 26570.734292656827, 26700.0, 26833.177043795924, 26834.731652683222, 26852.731472685806], "value": 14533.844899428364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.34540718042905, 354.12354422803554, 362.77145398399006, 366.34972923061565, 369.6211383332084, 13931.876275586024, 14368.784468232985, 14822.925885370558, 14870.033447825885, 14874.0, 11266.324020558772, 12935.223886566813, 13475.0, 13771.104878182936, 13887.0, 4887.6089912807065, 4951.925721114186, 5043.974780126113, 5096.974515127419, 5119.360079990001, 4918.385201849769, 4935.111679897617, 4948.901021979576, 4949.307097006422, 4972.602191824645, 4769.761511924407, 4918.581920536759, 4926.852194434155, 4931.827386041489, 4939.481354457784, 5077.314562534085, 5109.948900511003, 5112.156494178456, 5116.616253780981, 5117.692938423688, 4417.602415782563, 4567.040921406476, 4601.700889442175, 4609.67732258742, 4619.099275641252, 17461.0, 17478.126093695264, 17506.47480575572, 17588.91205543964, 17631.911840440716, 1728.8962662240306, 1825.3976187858107, 1899.5536049028467, 2018.2431588154443, 2026.5946810637784, 8473.322134229247, 8590.69932552364, 8619.525926074064, 8643.740687779376, 8746.475211487332, 1763.180121243615, 1847.8706490545667, 1876.1651065275958, 1879.144989029988, 1901.1729897494633, 53722.194167087524, 57893.0, 58928.41071589229, 59416.70291648514, 59887.0, 9193.264538836876, 9502.192313653279, 9508.239340852715, 9616.374935629161, 9769.51152442375, 13114.540991065267, 13143.737125257441, 13166.605001849959, 13195.67010824737, 13215.537456188988, 6662.167229096363, 6809.080774095532, 6971.093757811554, 6981.301869812978, 6999.790006299819, 6329.68351582419, 6371.39471750183, 6403.967980160162, 6483.351664833479, 6538.542302038812, 4133.772642504691, 4180.435641188401, 4183.748975061506, 4189.7695626740215, 4307.461567304087, 1769.3364988129451, 1784.2238626197645, 1793.5336812428602, 1796.4880009197316, 1823.680855850221, 762.4967521435826, 764.2472164917551, 836.7949852286229, 861.4572819123912, 890.1054440287598, 14337.06809057408, 14754.188519631309, 14796.408143674347, 14966.850331496764, 15167.165805880783, 805.472415567804, 831.5468069901918, 862.9266512346395, 891.197921870309, 897.9191872731485, 8225.79435514105, 8589.0, 8615.827683446296, 8660.350473714496, 8979.640814367483, 290079.0, 295141.0, 297503.0, 297677.0, 358819.0, 46021.30968035482, 55379.89240215173, 57799.711001444724, 68048.65975670189, 75072.24927750653, 947.5309721687809, 988.6786794291884, 997.8503224516236, 1004.0210794475474, 1009.5557954499997, 14420.927895360455, 14435.78346324827, 14573.854261457249, 14587.489437870048, 14744.262786860829, 32963.50554741633, 33027.66972330342, 33408.83295583507, 33521.66478335185, 34216.315673686884, 45713.31430028619, 46209.53790462052, 46281.53718462907, 46307.76846115748, 46337.768311159576, 6991.475639327173, 7067.293270672892, 7088.822779430556, 7256.89114663291, 7323.0, 9417.811643767223, 11086.279391839505, 11141.442927853737, 11306.095512359156, 11420.48607812667, 9935.751606209613, 10112.59549618007, 10168.28821982454, 10193.184545236216, 10388.896111038794, 9571.712848614552, 9724.902750972682, 9855.11303982645, 9870.901290987285, 10009.349392289478, 10116.544755486168, 10121.291509594257, 10145.9492702536, 10368.429736364573, 10403.167746580406, 6931.480138989495, 7343.70625174987, 7551.207123252199, 7611.467197296136, 7663.348615367756, 9690.37012594179, 10237.23220758461, 10266.538005789907, 10374.481275936323, 10584.788304234025], "value": 7620.084413328337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.2892409174951, 1325.5095614622592, 1342.9328533573325, 1567.521905818725, 1588.261458421835, 6438.935610643904, 7114.64426778661, 7305.890411643816, 7312.817179570513, 7379.667914943827, 7350.669219885104, 7446.553206807582, 7454.254574542543, 7456.850862982737, 7468.327850493454, 2181.0730439563163, 2221.7000704904794, 2226.2430773536994, 2248.932532024042, 2251.482159103399, 2169.566086782642, 2179.302623160589, 2219.6337604295272, 2220.0897631970897, 2220.289507357646, 2182.127149140341, 2204.184451752854, 2211.6903633491324, 2222.533268013719, 2253.504229069602, 2151.623465893478, 2163.2969284982364, 2165.7292838395124, 2166.664167054109, 2175.1734340950497, 2107.136074209582, 2133.136079887648, 2146.5063035501767, 2147.9355619331445, 2148.495103650641, 7566.205548417447, 7578.128515220765, 7587.393008559302, 7613.923860761377, 7616.04799400075, 4380.693351465398, 4571.977140114312, 4578.038611891507, 4578.175928332898, 4582.381378513925, 2833.9858300708365, 2904.390078083584, 2957.526795712697, 2974.2415684000657, 2985.1044686593937, 911.0661571888801, 915.6749353979375, 923.9214666753334, 924.4869097650801, 932.4172392254841, 10487.79024419515, 10500.159987201005, 10534.525946332433, 10569.41868197249, 10580.682579522627, 4145.626893579532, 4285.442892423965, 4291.270484017725, 4331.5884990925815, 4334.41485399467, 8897.021327653953, 8915.955420222987, 8963.0, 8995.55022248898, 9009.504477253682, 4544.045750392388, 4629.814807407666, 4657.813687452532, 4667.089917466062, 4668.603168730696, 3421.657834216608, 4054.7567145971334, 4092.7544347338658, 4207.852725154605, 4208.810603522848, 3431.5367425397253, 3442.9655703442645, 3472.652734726558, 3574.195805943694, 3598.838052287653, 1163.6101905861462, 1191.8152686333633, 1192.5904612606541, 1205.7889869272842, 1207.0404028797127, 710.9857802844018, 721.0482163544071, 751.3838652305058, 757.4394947738633, 758.7078974594821, 5158.0199762045095, 5162.793488260502, 5196.76614552346, 5201.0, 5324.547413469821, 400.9097952960561, 405.60453557780926, 405.73424407013454, 405.8924385037967, 409.76643313311126, 3573.94639080414, 3609.115766637138, 3615.7649752765988, 3676.558812942464, 3691.963080369162, 9347.953260233655, 9476.384035037701, 9658.034196580285, 9704.466254356079, 9746.366486178376, 9514.904850951401, 9523.190528804991, 9580.95209523948, 9651.71044868655, 9658.613655453702, 7113.53762005468, 7115.395191408788, 7239.638018099179, 7309.634518274065, 7392.778216653509, 5217.452167522356, 5231.163013917755, 5234.869128271824, 5322.09524380864, 5429.158480435539, 8796.956015219883, 8917.152870477294, 8955.104489550993, 8962.417442866194, 9000.774980625536, 8910.86633700482, 9072.228860546928, 9109.544522773702, 9252.0, 9263.722088337361, 6654.534182607171, 6692.765753198614, 6714.227863795726, 6757.45940324763, 6769.018492318488, 7226.168990566152, 7249.963750181215, 7259.9274007259255, 7285.052943117361, 7308.30571095745, 6561.737530498726, 6762.729490820312, 6811.69347379379, 6919.550229235084, 6937.340952609494, 6492.188476440445, 6595.340465953366, 6665.200175978914, 6723.5293529452465, 6740.090087838079, 6046.758129674764, 6055.878882422415, 6100.1459795629535, 6152.538559607958, 6193.597416167935, 4169.478815148106, 4257.233697934278, 4258.957410425856, 4327.134573085333, 4393.7363758174615, 4411.18393097278, 4486.7083639563325, 4527.4340707411575, 4533.750643714628, 4582.143177045408], "value": 3998.4832292878937, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.39574860906663, 299.91602351341623, 301.38367039404415, 303.78886673761735, 304.80949406620863, 4776.164171270027, 4876.292937524061, 4918.827841025569, 4928.679635823669, 4972.2541618757205, 4843.975780121094, 4868.245421959593, 4894.119058569456, 4899.848535594133, 4931.1617025105725, 3665.6700896919274, 3741.850325986971, 3873.7288389812725, 3880.4373365861934, 3913.9021524461905, 3865.4588357629955, 3869.9032524186837, 3876.8255428505645, 3878.495795546575, 3889.747166434173, 3826.4834247376666, 3830.942535861964, 3831.8275677594575, 3851.6504931991462, 3864.420336949452, 3778.357679194516, 3812.942805857914, 3859.36320507116, 3860.417228936137, 3876.8643097491595, 3402.2004828865197, 3404.8467818948207, 3409.6078950920464, 3416.24842534642, 3439.398105331582, 4715.976420117911, 4724.622030237572, 4750.548697873696, 4763.214069678499, 4774.140654682155, 4349.347597860315, 4402.339649052636, 4402.581754733295, 4403.141387429452, 4431.711938723973, 4864.318995340655, 5144.356955380577, 5157.922631160535, 5161.4322424533275, 5180.430152683201, 3631.364511210528, 3637.654422829827, 3657.8353974070965, 3673.651003154696, 3677.3380791457525, 5337.199420086979, 5447.536959358459, 5452.945470545284, 5457.345118585756, 5460.426655201226, 3520.9119772005392, 3727.1800203955086, 3743.21392507571, 3762.811859407019, 3783.2244389900557, 3787.16682329887, 3790.7156963227317, 3805.904852378713, 3811.2187001664593, 3822.3884178531302, 4335.588119128678, 4342.458427258341, 4353.499347575006, 4354.303311470149, 4378.6278166356215, 4907.975460122677, 5173.663711858717, 5186.5850731941355, 5203.453637368098, 5206.817761378334, 1351.2973253907912, 1354.8983826213073, 1361.46902707944, 1362.6320893358738, 1364.3451143451, 880.4365206267994, 907.8138981508774, 925.6898938855425, 938.4275591888942, 940.9623615055322, 4346.6522678185665, 4437.0, 4538.29656403258, 4598.172328980749, 4616.8614941551805, 5339.546138578265, 5353.330833645794, 5366.543843773245, 5377.3816011159215, 5378.381486129067, 4553.590176884097, 4567.10941366437, 4594.310853372021, 4606.723596584216, 4629.236176030984, 2926.443975644621, 3066.739327157217, 3068.324968506925, 3073.1548824073557, 3077.415291094685, 5391.7034563099405, 5431.864203394946, 5434.858679677233, 5437.0, 5457.372402173801, 5244.921326180111, 5487.314085739283, 5833.883322333614, 5885.411458854081, 5907.70461476933, 5060.190369540929, 5083.364579427572, 5094.6819197265895, 5098.668586541937, 5110.616703747234, 5392.487713667196, 5393.568514518907, 5401.4868587484125, 5407.486288802557, 5412.458754124556, 5185.714785686823, 5272.815451459181, 5279.656822306538, 5296.920546191733, 5315.415304316445, 5034.597232221487, 5034.874128146826, 5075.162598171408, 5089.338386009943, 5090.338256026693, 3832.0, 3891.124496988155, 3892.9805350973065, 3897.785621790829, 3922.941155882607, 5132.384113906355, 5186.299849520417, 5308.309919710413, 5311.309529761106, 5388.299521062237, 5167.844964651066, 5171.6553696040055, 5173.896522069463, 5176.534111929945, 5204.2193670948145, 5118.820841270538, 5119.820806271762, 5141.87145321355, 5149.562287205629, 5169.974150129226, 4755.690880092783, 5104.591632669451, 5145.974270128625, 5160.225966105114, 5176.663516871391, 5001.674221487026, 5046.1673823818655, 5200.765965531485, 5212.791488340424, 5225.790968361223, 5048.91448338609, 5052.393712754493, 5096.992774263203, 5104.285400044071, 5128.461511541234], "value": 3928.5546240273216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4271064869158, 590.8759160576279, 603.7998607380881, 640.7372977079399, 662.8508585568247, 11779.23434976726, 11932.1647484676, 12198.14612977092, 12267.877321226784, 12447.813282800766, 10886.0, 10924.344539327645, 10962.945185274062, 10985.780284394308, 11009.559617615285, 506.6681323732961, 508.3340823521199, 525.2305372629097, 528.6537318056679, 546.3307448375728, 528.6220352447999, 529.2933933199183, 531.2960327565971, 534.6391185949468, 536.4903341825262, 549.5191707256151, 551.4265164229217, 552.3923683947665, 556.7717235933268, 556.9443055694438, 684.2029036172853, 689.434663575868, 696.9128858892639, 700.9228984811666, 706.2443185791205, 407.1490584678007, 409.3430044778118, 411.3315861724697, 411.9361498967665, 412.581230051498, 10896.564137434492, 10984.0, 11007.339559626447, 11055.502502387411, 11057.281276717069, 11132.610358637408, 11344.43277836105, 11351.262167959056, 11435.085193184608, 11695.824562631567, 9624.236171732386, 9672.129508344213, 9788.363756355815, 9834.508274586242, 9854.359466634645, 3305.685959833812, 3323.9833800830843, 3344.8494817733263, 3359.9496007559906, 3451.8263790311416, 42128.645068107864, 42313.78843105765, 42349.57650423487, 42546.57453425488, 44148.77925610384, 9654.806903862023, 9849.55676994537, 9864.556094975744, 9876.555555000043, 9936.056074672895, 15132.470363537223, 15159.393624254906, 15742.763858542132, 16042.0, 16059.277332520065, 6142.662153581596, 6223.564350495421, 6313.55805093639, 6329.272133704683, 6427.421532062137, 3549.290141971616, 3645.8906232813056, 3655.3420384331075, 3736.7757934524016, 3754.3992961126087, 2513.170653684316, 2573.7297583753434, 2576.6135079737815, 2831.292176955761, 2955.423692380008, 508.47118996244234, 510.39008384979593, 516.4938360406748, 528.4240178205774, 537.3820106877045, 576.0127559918299, 577.5206578539802, 588.6144575303098, 589.0898561722149, 597.0387675841891, 7697.461177717506, 7884.0, 7971.322437592754, 8120.959395202986, 8192.057913339922, 547.5400663442648, 548.3529435266424, 588.109014842514, 593.4718100890211, 618.8886000519859, 3567.4113771227458, 3707.295613833363, 3773.113318370181, 3917.5690674025836, 3922.4312474691583, 45664.0, 49115.0, 50303.496965030616, 50346.49653503418, 50477.24284135741, 42126.578734212875, 42489.36265956013, 46064.309035364495, 46641.83395415074, 46927.53072469232, 42132.57867421348, 42314.57685423168, 42346.576534234264, 42873.0, 42932.570674293485, 7497.700091996478, 7814.609269536387, 7825.491343062683, 7858.528488290721, 7868.488548244346, 28481.43037139204, 29392.853035734686, 29682.703172967995, 29786.255343616584, 30238.84880575583, 35925.0, 37393.6260637401, 37496.437553436175, 38019.42970855384, 38098.23803523859, 9538.713838584854, 9608.423494590346, 9702.369345992487, 10118.568432769682, 10318.896811031793, 11189.160812939224, 11251.493682784458, 11399.487023083815, 11604.897534734188, 11672.533098676298, 9598.472084035446, 9631.855522167032, 9654.275929305471, 10034.849477257701, 10910.399928004035, 9809.852852207365, 9869.309148359545, 10033.247506437192, 10049.246306527186, 10416.479176041319, 10369.9481502592, 10477.580896764044, 10578.947105264424, 10654.680359589225, 10747.301425407324, 9323.487208203615, 9451.527423628928, 9565.378250413702, 9603.855942160733, 9816.950915245377, 9016.143466370684, 9234.538273086184, 9281.67514137002, 9331.58007889633, 9394.201492873182], "value": 5423.846427669943, "unit": "score"}], "name": "dromaeo_css", "value": 5911.71768516693, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 113.0, 116.0, 126.0, 116.0, 113.0, 114.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 131.0, 163.0, 182.0, 134.0, 170.0, 163.0, 133.0, 205.0, 134.0], "value": 158.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 173.0, 165.0, 163.0, 164.0, 162.0, 165.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 149.0, 78.0, 77.0, 74.0, 76.0, 158.0, 74.0], "value": 91.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 155.0, 95.0, 94.0, 93.0, 137.0, 94.0, 95.0, 147.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 148.0, 148.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 73.0, 66.0, 66.0, 66.0, 69.0, 93.0, 64.0, 65.0], "value": 69.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 64.0, 64.0, 65.0, 63.0, 65.0, 69.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 89.0, 79.0, 80.0, 80.0, 80.0, 81.0, 81.0, 85.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 144.0, 142.0, 138.0, 139.0, 141.0, 134.0, 167.0, 136.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 226.0, 217.0, 222.0, 222.0, 217.0, 213.0, 219.0, 226.0, 217.0], "value": 220.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 77.0, 76.0, 74.0, 77.0, 75.0, 75.0, 78.0, 76.0], "value": 76.7, "unit": "score"}], "name": "kraken", "value": 1653.0000000000002, "alertThreshold": 2.0}]} 13:05:48 INFO - Return code: 0 13:05:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:05:49 ERROR - # TBPL SUCCESS # 13:05:49 INFO - Running post-action listener: _resource_record_post_action 13:05:49 INFO - Running post-run listener: _resource_record_post_run 13:05:50 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370532352; Read time: 16; Write time: 187896 13:05:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 73678848; Read time: 0; Write time: 33844 13:05:50 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296853504; Read time: 16; Write time: 154052 13:05:50 INFO - Running post-run listener: _upload_blobber_files 13:05:50 INFO - Blob upload gear active. 13:05:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:05:50 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 13:05:50 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:05:50 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:05:50 INFO - (blobuploader) - INFO - Open directory for files ... 13:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:05:51 INFO - (blobuploader) - INFO - Done attempting. 13:05:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:05:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:05:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:05:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:05:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:05:52 INFO - (blobuploader) - INFO - Done attempting. 13:05:52 INFO - (blobuploader) - INFO - Iteration through files over. 13:05:52 INFO - Return code: 0 13:05:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:05:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:05:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef7da26212caac33f770453a348254be84c19d2d1181a4182daa909fa9dd66c6da8aa76228fe70df60ef68a7981cd240e7cd6256bb7f924c341d978d6c2efbb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff916d8f4c242e47cce7d74d54037247811d717361a06461c4e9ccf17a7630ac3f44450a59b516fd991ec54e33eeb7c150b4897d480a7ca691421f28fa9efc8c"} 13:05:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:05:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:05:52 INFO - Contents: 13:05:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef7da26212caac33f770453a348254be84c19d2d1181a4182daa909fa9dd66c6da8aa76228fe70df60ef68a7981cd240e7cd6256bb7f924c341d978d6c2efbb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff916d8f4c242e47cce7d74d54037247811d717361a06461c4e9ccf17a7630ac3f44450a59b516fd991ec54e33eeb7c150b4897d480a7ca691421f28fa9efc8c"} 13:05:52 INFO - Running post-run listener: copy_logs_to_upload_dir 13:05:52 INFO - Copying logs to upload dir... 13:05:52 INFO - mkdir: /builds/slave/test/build/upload/logs 13:05:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.397895 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-26 13:05:51.649101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 13:05:51.653200) ========= 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=ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208 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-Non-PGO/sha512/ef7da26212caac33f770453a348254be84c19d2d1181a4182daa909fa9dd66c6da8aa76228fe70df60ef68a7981cd240e7cd6256bb7f924c341d978d6c2efbb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff916d8f4c242e47cce7d74d54037247811d717361a06461c4e9ccf17a7630ac3f44450a59b516fd991ec54e33eeb7c150b4897d480a7ca691421f28fa9efc8c"} build_url:https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009033 build_url: 'https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/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-Non-PGO/sha512/ef7da26212caac33f770453a348254be84c19d2d1181a4182daa909fa9dd66c6da8aa76228fe70df60ef68a7981cd240e7cd6256bb7f924c341d978d6c2efbb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff916d8f4c242e47cce7d74d54037247811d717361a06461c4e9ccf17a7630ac3f44450a59b516fd991ec54e33eeb7c150b4897d480a7ca691421f28fa9efc8c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 13:05:51.676762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:05:51.677331) ========= 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=ed14279e38b05397cf4aa391000001a4-1461698761.623750-1078709208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003184 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:05:51.726340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 13:05:51.726855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 13:05:51.727255) ========= ========= Total master_lag: 0.50 =========