builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1450433006.03 results: success (0) buildid: 20151218011655 builduid: 75aaa4f7f2174d7389eb4ece08dcaf66 revision: b32c4163ff05bd0293aa4e1cebc6636aaef60e1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.030375) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.030915) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.031219) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=d16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006218 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.054744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.055348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.069158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.069587) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=d16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004715 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.120740) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.121071) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.121513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.121931) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 02:03:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2015-12-18 02:03:27 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165996 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.300391) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.300711) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=d16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020871 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:26.350557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 02:03:26.351028) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b32c4163ff05bd0293aa4e1cebc6636aaef60e1c --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 b32c4163ff05bd0293aa4e1cebc6636aaef60e1c --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=d16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 02:03:27,895 truncating revision to first 12 chars 2015-12-18 02:03:27,895 Setting DEBUG logging. 2015-12-18 02:03:27,895 attempt 1/10 2015-12-18 02:03:27,895 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b32c4163ff05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 02:03:28,939 unpacking tar archive at: fx-team-b32c4163ff05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 02:03:27.686966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:27.687240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:27.696267) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:27.696543) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:27.696938) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-18 02:03:27.697234) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=d16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:03:29 INFO - MultiFileLogger online at 20151218 02:03:29 in /builds/slave/test 02:03:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:03:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:03:29 INFO - {'append_to_log': False, 02:03:29 INFO - 'base_work_dir': '/builds/slave/test', 02:03:29 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:03:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:03:29 INFO - 'branch': 'Fx-Team-Non-PGO', 02:03:29 INFO - 'buildbot_json_path': 'buildprops.json', 02:03:29 INFO - 'config_files': ('talos/linux_config.py',), 02:03:29 INFO - 'default_actions': ('clobber', 02:03:29 INFO - 'read-buildbot-config', 02:03:29 INFO - 'download-and-extract', 02:03:29 INFO - 'populate-webroot', 02:03:29 INFO - 'create-virtualenv', 02:03:29 INFO - 'install', 02:03:29 INFO - 'run-tests'), 02:03:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:03:29 INFO - 'download_minidump_stackwalk': True, 02:03:29 INFO - 'download_symbols': 'ondemand', 02:03:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:03:29 INFO - 'tooltool.py': '/tools/tooltool.py', 02:03:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:03:29 INFO - '/tools/misc-python/virtualenv.py')}, 02:03:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:03:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:03:29 INFO - 'installer_path': 'installer.exe', 02:03:29 INFO - 'log_level': 'info', 02:03:29 INFO - 'log_name': 'talos', 02:03:29 INFO - 'log_to_console': True, 02:03:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:03:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:03:29 INFO - 'opt_config_files': (), 02:03:29 INFO - 'pip_index': False, 02:03:29 INFO - 'sps_profile': False, 02:03:29 INFO - 'sps_profile_interval': 0, 02:03:29 INFO - 'suite': 'dromaeojs-e10s', 02:03:29 INFO - 'system_bits': '64', 02:03:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:03:29 INFO - 'title': 'talos-linux64-ix-034', 02:03:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:03:29 INFO - 'use_talos_json': True, 02:03:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:03:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:03:29 INFO - 'work_dir': 'build'} 02:03:29 INFO - ##### 02:03:29 INFO - ##### Running clobber step. 02:03:29 INFO - ##### 02:03:29 INFO - Running pre-action listener: _resource_record_pre_action 02:03:29 INFO - Running main action method: clobber 02:03:29 INFO - rmtree: /builds/slave/test/build 02:03:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:03:29 INFO - Running post-action listener: _resource_record_post_action 02:03:29 INFO - ##### 02:03:29 INFO - ##### Running read-buildbot-config step. 02:03:29 INFO - ##### 02:03:29 INFO - Running pre-action listener: _resource_record_pre_action 02:03:29 INFO - Running main action method: read_buildbot_config 02:03:29 INFO - Using buildbot properties: 02:03:29 INFO - { 02:03:29 INFO - "project": "", 02:03:29 INFO - "product": "firefox", 02:03:29 INFO - "script_repo_revision": "production", 02:03:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:03:29 INFO - "repository": "", 02:03:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:03:29 INFO - "buildid": "20151218011655", 02:03:29 INFO - "pgo_build": "False", 02:03:29 INFO - "basedir": "/builds/slave/test", 02:03:29 INFO - "buildnumber": 581, 02:03:29 INFO - "slavename": "talos-linux64-ix-034", 02:03:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:03:29 INFO - "platform": "ubuntu64_hw", 02:03:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:03:29 INFO - "branch": "fx-team", 02:03:29 INFO - "repo_path": "integration/fx-team", 02:03:29 INFO - "revision": "b32c4163ff05bd0293aa4e1cebc6636aaef60e1c", 02:03:29 INFO - "stage_platform": "linux64", 02:03:29 INFO - "builduid": "75aaa4f7f2174d7389eb4ece08dcaf66", 02:03:29 INFO - "slavebuilddir": "test" 02:03:29 INFO - } 02:03:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:03:29 INFO - Running post-action listener: _resource_record_post_action 02:03:29 INFO - ##### 02:03:29 INFO - ##### Running download-and-extract step. 02:03:29 INFO - ##### 02:03:29 INFO - Running pre-action listener: _resource_record_pre_action 02:03:29 INFO - Running main action method: download_and_extract 02:03:29 INFO - mkdir: /builds/slave/test/build/tests 02:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:29 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:03:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json 02:03:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json 02:03:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:03:38 INFO - Downloaded 1302 bytes. 02:03:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:03:38 INFO - Using the following test package requirements: 02:03:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:03:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:03:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:38 INFO - u'jsshell-linux-x86_64.zip'], 02:03:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:03:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:03:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:03:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:03:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:03:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:03:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:03:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:38 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:03:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:03:40 INFO - Downloaded 21870957 bytes. 02:03:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:03:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:03:41 INFO - Return code: 0 02:03:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:41 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:03:46 INFO - Downloaded 21870957 bytes. 02:03:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:03:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:03:47 INFO - Return code: 0 02:03: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')]} 02:03:47 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:03:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:03:48 INFO - Downloaded 11132039 bytes. 02:03:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 02:03:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:03:48 INFO - Return code: 0 02:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:48 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:03:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:03:50 INFO - Downloaded 53019526 bytes. 02:03:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:50 INFO - mkdir: /builds/slave/test/properties 02:03:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:03:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:03:50 INFO - Contents: 02:03:50 INFO - build_url:https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:50 INFO - Running post-action listener: _resource_record_post_action 02:03:50 INFO - Running post-action listener: set_extra_try_arguments 02:03:50 INFO - ##### 02:03:50 INFO - ##### Running populate-webroot step. 02:03:50 INFO - ##### 02:03:50 INFO - Running pre-action listener: _resource_record_pre_action 02:03:50 INFO - Running main action method: populate_webroot 02:03:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:03:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:03:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:03:50 INFO - '--tppagecycles', 02:03:50 INFO - '7'], 02:03:50 INFO - 'tests': ['tsvgm']}}, 02:03:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:03:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:03:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:03:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:03:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:03:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:03:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:03:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:50 INFO - 'talos_options': ['--e10s'], 02:03:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:03:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:50 INFO - 'tests': ['damp', 'tps']}, 02:03:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:50 INFO - 'talos_options': ['--e10s'], 02:03:50 INFO - 'tests': ['damp', 'tps']}, 02:03:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:03:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:03:50 INFO - 'other': {'tests': ['a11yr', 02:03:50 INFO - 'ts_paint', 02:03:50 INFO - 'tpaint', 02:03:50 INFO - 'sessionrestore', 02:03:50 INFO - 'sessionrestore_no_auto_restore']}, 02:03:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:03:50 INFO - 'tests': ['a11yr', 02:03:50 INFO - 'ts_paint', 02:03:50 INFO - 'tpaint', 02:03:50 INFO - 'sessionrestore', 02:03:50 INFO - 'sessionrestore_no_auto_restore']}, 02:03:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:03:50 INFO - 'tests': ['a11yr', 02:03:50 INFO - 'ts_paint', 02:03:50 INFO - 'tpaint', 02:03:50 INFO - 'sessionrestore', 02:03:50 INFO - 'sessionrestore_no_auto_restore']}, 02:03:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:03:50 INFO - 'tests': ['a11yr', 02:03:50 INFO - 'ts_paint', 02:03:50 INFO - 'tpaint', 02:03:50 INFO - 'sessionrestore', 02:03:50 INFO - 'sessionrestore_no_auto_restore']}, 02:03:50 INFO - 'other_l64': {'tests': ['a11yr', 02:03:50 INFO - 'ts_paint', 02:03:50 INFO - 'tpaint', 02:03:50 INFO - 'sessionrestore', 02:03:50 INFO - 'sessionrestore_no_auto_restore']}, 02:03:50 INFO - 'other_nol64': {'tests': ['a11yr', 02:03:50 INFO - 'ts_paint', 02:03:50 INFO - 'tpaint', 02:03:50 INFO - 'sessionrestore', 02:03:50 INFO - 'sessionrestore_no_auto_restore']}, 02:03:50 INFO - 'svgr': {'tests': ['tsvgx', 02:03:50 INFO - 'tsvgr_opacity', 02:03:50 INFO - 'tart', 02:03:50 INFO - 'tscrollx', 02:03:50 INFO - 'cart']}, 02:03:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:03:50 INFO - 'tests': ['tsvgx', 02:03:50 INFO - 'tsvgr_opacity', 02:03:50 INFO - 'tart', 02:03:50 INFO - 'tscrollx', 02:03:50 INFO - 'cart']}, 02:03:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:50 INFO - 'tests': ['tp5o']}, 02:03:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:50 INFO - 'talos_options': ['--e10s'], 02:03:50 INFO - 'tests': ['tp5o']}, 02:03:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:50 INFO - 'talos_options': ['--xperf_path', 02:03:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:03:50 INFO - 'tests': ['tp5n']}, 02:03:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:50 INFO - 'talos_options': ['--e10s', 02:03:50 INFO - '--xperf_path', 02:03:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:03:50 INFO - 'tests': ['tp5n']}}, 02:03:50 INFO - 'talos.zip': {'path': '', 02:03:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:03:50 INFO - Running post-action listener: _resource_record_post_action 02:03:50 INFO - ##### 02:03:50 INFO - ##### Running create-virtualenv step. 02:03:50 INFO - ##### 02:03:50 INFO - Running pre-action listener: _resource_record_pre_action 02:03:50 INFO - Running main action method: create_virtualenv 02:03:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:03:50 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 02:03:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:03:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:03:50 INFO - Using real prefix '/usr' 02:03:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:03:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:03:52 INFO - Installing pip.................done. 02:03:52 INFO - Return code: 0 02:03:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:03:52 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')]} 02:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:52 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')]} 02:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f68fdac8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd51240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', '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 02:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 02:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:03:52 INFO - Using env: {'DISPLAY': ':0', 02:03:52 INFO - 'HOME': '/home/cltbld', 02:03:52 INFO - 'LANG': 'en_US.UTF-8', 02:03:52 INFO - 'LANGUAGE': 'en_US:en', 02:03:52 INFO - 'LOGNAME': 'cltbld', 02:03:52 INFO - 'MAIL': '/var/mail/cltbld', 02:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:52 INFO - 'MOZ_NO_REMOTE': '1', 02:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:52 INFO - 'NO_EM_RESTART': '1', 02:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:52 INFO - 'PWD': '/builds/slave/test', 02:03:52 INFO - 'SHELL': '/bin/bash', 02:03:52 INFO - 'SHLVL': '1', 02:03:52 INFO - 'TERM': 'linux', 02:03:52 INFO - 'TMOUT': '86400', 02:03:52 INFO - 'USER': 'cltbld', 02:03:52 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:52 INFO - '_': '/tools/buildbot/bin/python'} 02:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:53 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 02:03:53 INFO - Cleaning up... 02:03:53 INFO - Return code: 0 02:03:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:03:53 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')]} 02:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:53 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')]} 02:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f68fdac8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd51240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', '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 02:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 02:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:03:53 INFO - Using env: {'DISPLAY': ':0', 02:03:53 INFO - 'HOME': '/home/cltbld', 02:03:53 INFO - 'LANG': 'en_US.UTF-8', 02:03:53 INFO - 'LANGUAGE': 'en_US:en', 02:03:53 INFO - 'LOGNAME': 'cltbld', 02:03:53 INFO - 'MAIL': '/var/mail/cltbld', 02:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:53 INFO - 'MOZ_NO_REMOTE': '1', 02:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:53 INFO - 'NO_EM_RESTART': '1', 02:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:53 INFO - 'PWD': '/builds/slave/test', 02:03:53 INFO - 'SHELL': '/bin/bash', 02:03:53 INFO - 'SHLVL': '1', 02:03:53 INFO - 'TERM': 'linux', 02:03:53 INFO - 'TMOUT': '86400', 02:03:53 INFO - 'USER': 'cltbld', 02:03:53 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:53 INFO - '_': '/tools/buildbot/bin/python'} 02:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:53 INFO - Downloading/unpacking psutil>=0.7.1 02:03:53 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 02:03:53 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 02:03:53 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 02:03:53 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 02:03:53 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 02:03:53 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 02:03:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:03:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:03:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:03:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:03:55 INFO - Installing collected packages: psutil 02:03:55 INFO - Running setup.py install for psutil 02:03:55 INFO - building 'psutil._psutil_linux' extension 02:03:55 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 02:03:55 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 02:03:55 INFO - building 'psutil._psutil_posix' extension 02:03:55 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 02:03:55 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 02:03:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:03:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:03:55 INFO - Successfully installed psutil 02:03:55 INFO - Cleaning up... 02:03:55 INFO - Return code: 0 02:03:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f68fdac8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd51240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', '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 02:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 02:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:03:55 INFO - Using env: {'DISPLAY': ':0', 02:03:55 INFO - 'HOME': '/home/cltbld', 02:03:55 INFO - 'LANG': 'en_US.UTF-8', 02:03:55 INFO - 'LANGUAGE': 'en_US:en', 02:03:55 INFO - 'LOGNAME': 'cltbld', 02:03:55 INFO - 'MAIL': '/var/mail/cltbld', 02:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:55 INFO - 'MOZ_NO_REMOTE': '1', 02:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:55 INFO - 'NO_EM_RESTART': '1', 02:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:55 INFO - 'PWD': '/builds/slave/test', 02:03:55 INFO - 'SHELL': '/bin/bash', 02:03:55 INFO - 'SHLVL': '1', 02:03:55 INFO - 'TERM': 'linux', 02:03:55 INFO - 'TMOUT': '86400', 02:03:55 INFO - 'USER': 'cltbld', 02:03:55 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:55 INFO - '_': '/tools/buildbot/bin/python'} 02:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:03:55 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 02:03:55 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 02:03:55 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 02:03:55 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 02:03:55 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 02:03:55 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 02:03:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:03:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:03:57 INFO - Installing collected packages: mozsystemmonitor 02:03:57 INFO - Running setup.py install for mozsystemmonitor 02:03:57 INFO - Successfully installed mozsystemmonitor 02:03:57 INFO - Cleaning up... 02:03:57 INFO - Return code: 0 02:03:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f68fdac8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd51240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', '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 02:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 02:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:03:57 INFO - Using env: {'DISPLAY': ':0', 02:03:57 INFO - 'HOME': '/home/cltbld', 02:03:57 INFO - 'LANG': 'en_US.UTF-8', 02:03:57 INFO - 'LANGUAGE': 'en_US:en', 02:03:57 INFO - 'LOGNAME': 'cltbld', 02:03:57 INFO - 'MAIL': '/var/mail/cltbld', 02:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:57 INFO - 'MOZ_NO_REMOTE': '1', 02:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:57 INFO - 'NO_EM_RESTART': '1', 02:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:57 INFO - 'PWD': '/builds/slave/test', 02:03:57 INFO - 'SHELL': '/bin/bash', 02:03:57 INFO - 'SHLVL': '1', 02:03:57 INFO - 'TERM': 'linux', 02:03:57 INFO - 'TMOUT': '86400', 02:03:57 INFO - 'USER': 'cltbld', 02:03:57 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:57 INFO - '_': '/tools/buildbot/bin/python'} 02:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:58 INFO - Downloading/unpacking blobuploader==1.2.4 02:03:58 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 02:03:58 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 02:03:58 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 02:03:58 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 02:03:58 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 02:03:58 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 02:03:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:03:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:03:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:04:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:04:00 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 02:04:00 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 02:04:00 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 02:04:00 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 02:04:00 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 02:04:00 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 02:04:00 INFO - Downloading docopt-0.6.1.tar.gz 02:04:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:04:00 INFO - Installing collected packages: blobuploader, requests, docopt 02:04:00 INFO - Running setup.py install for blobuploader 02:04:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:04:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:04:00 INFO - Running setup.py install for requests 02:04:00 INFO - Running setup.py install for docopt 02:04:01 INFO - Successfully installed blobuploader requests docopt 02:04:01 INFO - Cleaning up... 02:04:01 INFO - Return code: 0 02:04:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f68fdac8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd51240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', '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 02:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 02:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 02:04:01 INFO - Using env: {'DISPLAY': ':0', 02:04:01 INFO - 'HOME': '/home/cltbld', 02:04:01 INFO - 'LANG': 'en_US.UTF-8', 02:04:01 INFO - 'LANGUAGE': 'en_US:en', 02:04:01 INFO - 'LOGNAME': 'cltbld', 02:04:01 INFO - 'MAIL': '/var/mail/cltbld', 02:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:01 INFO - 'MOZ_NO_REMOTE': '1', 02:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:01 INFO - 'NO_EM_RESTART': '1', 02:04:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:01 INFO - 'PWD': '/builds/slave/test', 02:04:01 INFO - 'SHELL': '/bin/bash', 02:04:01 INFO - 'SHLVL': '1', 02:04:01 INFO - 'TERM': 'linux', 02:04:01 INFO - 'TMOUT': '86400', 02:04:01 INFO - 'USER': 'cltbld', 02:04:01 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:01 INFO - '_': '/tools/buildbot/bin/python'} 02:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:04:01 INFO - Running setup.py (path:/tmp/pip-ZOMkcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:04:01 INFO - Running setup.py (path:/tmp/pip-bkBFHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:04:01 INFO - Running setup.py (path:/tmp/pip-OnPbaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:04:01 INFO - Running setup.py (path:/tmp/pip-jtnrTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:04:01 INFO - Running setup.py (path:/tmp/pip-wGL4e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:04:01 INFO - Running setup.py (path:/tmp/pip-tBi_qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:04:01 INFO - Running setup.py (path:/tmp/pip-5v8cKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:04:01 INFO - Running setup.py (path:/tmp/pip-cFqpry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:04:01 INFO - Running setup.py (path:/tmp/pip-WVbtMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:04:01 INFO - Running setup.py (path:/tmp/pip-sv_EB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:04:02 INFO - Running setup.py (path:/tmp/pip-qhT4Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:04:02 INFO - Running setup.py (path:/tmp/pip-xlkQ2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:04:02 INFO - Running setup.py (path:/tmp/pip-IqthEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:04:02 INFO - Running setup.py (path:/tmp/pip-78C_9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:02 INFO - Running setup.py (path:/tmp/pip-ngi4DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:04:02 INFO - Running setup.py (path:/tmp/pip-liq4fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:04:02 INFO - Running setup.py (path:/tmp/pip-H5lnJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:04:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:04:02 INFO - Running setup.py install for manifestparser 02:04:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:04:02 INFO - Running setup.py install for mozcrash 02:04:02 INFO - Running setup.py install for mozdebug 02:04:02 INFO - Running setup.py install for mozdevice 02:04:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:04:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:04:02 INFO - Running setup.py install for mozfile 02:04:03 INFO - Running setup.py install for mozhttpd 02:04:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Running setup.py install for mozinfo 02:04:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Running setup.py install for mozInstall 02:04:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Running setup.py install for mozleak 02:04:03 INFO - Running setup.py install for mozlog 02:04:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Running setup.py install for moznetwork 02:04:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Running setup.py install for mozprocess 02:04:03 INFO - Running setup.py install for mozprofile 02:04:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Running setup.py install for mozrunner 02:04:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:04:03 INFO - Running setup.py install for mozscreenshot 02:04:04 INFO - Running setup.py install for moztest 02:04:04 INFO - Running setup.py install for mozversion 02:04:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:04:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:04:04 INFO - Cleaning up... 02:04:04 INFO - Return code: 0 02:04:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:04:04 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')]} 02:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:04 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')]} 02:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f68fdac8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd51240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', '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 02:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 02:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:04:04 INFO - Using env: {'DISPLAY': ':0', 02:04:04 INFO - 'HOME': '/home/cltbld', 02:04:04 INFO - 'LANG': 'en_US.UTF-8', 02:04:04 INFO - 'LANGUAGE': 'en_US:en', 02:04:04 INFO - 'LOGNAME': 'cltbld', 02:04:04 INFO - 'MAIL': '/var/mail/cltbld', 02:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:04 INFO - 'MOZ_NO_REMOTE': '1', 02:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:04 INFO - 'NO_EM_RESTART': '1', 02:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:04 INFO - 'PWD': '/builds/slave/test', 02:04:04 INFO - 'SHELL': '/bin/bash', 02:04:04 INFO - 'SHLVL': '1', 02:04:04 INFO - 'TERM': 'linux', 02:04:04 INFO - 'TMOUT': '86400', 02:04:04 INFO - 'USER': 'cltbld', 02:04:04 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:04 INFO - '_': '/tools/buildbot/bin/python'} 02:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:04:04 INFO - Running setup.py (path:/tmp/pip-RxmR65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:04:04 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)) 02:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:04:04 INFO - Running setup.py (path:/tmp/pip-dKhcYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 02:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:04:04 INFO - Running setup.py (path:/tmp/pip-GESPyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:04:04 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)) 02:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:04:04 INFO - Running setup.py (path:/tmp/pip-N6v7Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 02:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:04:04 INFO - Running setup.py (path:/tmp/pip-65KnUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:04:04 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)) 02:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:04:04 INFO - Running setup.py (path:/tmp/pip-alveg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:04:04 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)) 02:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:04:04 INFO - Running setup.py (path:/tmp/pip-Vh6EIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:04:05 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:04:05 INFO - Running setup.py (path:/tmp/pip-Z61R1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:04:05 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:04:05 INFO - Running setup.py (path:/tmp/pip-HZCfgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:04:05 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:04:05 INFO - Running setup.py (path:/tmp/pip-0Q8oVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:04:05 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:04:05 INFO - Running setup.py (path:/tmp/pip-ZX_QiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:04:05 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:04:05 INFO - Running setup.py (path:/tmp/pip-N4ro6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:04:05 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:04:05 INFO - Running setup.py (path:/tmp/pip-8aOX5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:04:05 INFO - Running setup.py (path:/tmp/pip-4OdKa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:04:05 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:05 INFO - Running setup.py (path:/tmp/pip-JXIZsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:05 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:04:05 INFO - Running setup.py (path:/tmp/pip-7Q4YbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:04:05 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)) 02:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:04:05 INFO - Running setup.py (path:/tmp/pip-chn05j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:04:05 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)) 02:04:05 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:04:05 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:04:05 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)) 02:04:05 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:04:05 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:04:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:04:05 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 02:04:05 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 02:04:05 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 02:04:05 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 02:04:05 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 02:04:05 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 02:04:07 INFO - Downloading blessings-1.5.1.tar.gz 02:04:07 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:04:07 INFO - Installing collected packages: blessings 02:04:07 INFO - Running setup.py install for blessings 02:04:07 INFO - Successfully installed blessings 02:04:07 INFO - Cleaning up... 02:04:07 INFO - Return code: 0 02:04:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:04:08 INFO - Reading from file tmpfile_stdout 02:04:08 INFO - Current package versions: 02:04:08 INFO - argparse == 1.2.1 02:04:08 INFO - blessings == 1.5.1 02:04:08 INFO - blobuploader == 1.2.4 02:04:08 INFO - docopt == 0.6.1 02:04:08 INFO - manifestparser == 1.1 02:04:08 INFO - mozInstall == 1.12 02:04:08 INFO - mozcrash == 0.16 02:04:08 INFO - mozdebug == 0.1 02:04:08 INFO - mozdevice == 0.47 02:04:08 INFO - mozfile == 1.2 02:04:08 INFO - mozhttpd == 0.7 02:04:08 INFO - mozinfo == 0.9 02:04:08 INFO - mozleak == 0.1 02:04:08 INFO - mozlog == 3.1 02:04:08 INFO - moznetwork == 0.27 02:04:08 INFO - mozprocess == 0.22 02:04:08 INFO - mozprofile == 0.27 02:04:08 INFO - mozrunner == 6.11 02:04:08 INFO - mozscreenshot == 0.1 02:04:08 INFO - mozsystemmonitor == 0.0 02:04:08 INFO - moztest == 0.7 02:04:08 INFO - mozversion == 1.4 02:04:08 INFO - psutil == 3.1.1 02:04:08 INFO - requests == 1.2.3 02:04:08 INFO - wsgiref == 0.1.2 02:04:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:04: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')]} 02:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04: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')]} 02:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f68fdac8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd51240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', '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 02:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 02:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:04:08 INFO - Using env: {'DISPLAY': ':0', 02:04:08 INFO - 'HOME': '/home/cltbld', 02:04:08 INFO - 'LANG': 'en_US.UTF-8', 02:04:08 INFO - 'LANGUAGE': 'en_US:en', 02:04:08 INFO - 'LOGNAME': 'cltbld', 02:04:08 INFO - 'MAIL': '/var/mail/cltbld', 02:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:08 INFO - 'MOZ_NO_REMOTE': '1', 02:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:08 INFO - 'NO_EM_RESTART': '1', 02:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:08 INFO - 'PWD': '/builds/slave/test', 02:04:08 INFO - 'SHELL': '/bin/bash', 02:04:08 INFO - 'SHLVL': '1', 02:04:08 INFO - 'TERM': 'linux', 02:04:08 INFO - 'TMOUT': '86400', 02:04:08 INFO - 'USER': 'cltbld', 02:04:08 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:08 INFO - '_': '/tools/buildbot/bin/python'} 02:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:08 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 1)) 02:04:08 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 2)) 02:04:08 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 3)) 02:04:08 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 4)) 02:04:08 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 5)) 02:04:08 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 6)) 02:04:08 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 7)) 02:04:08 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 8)) 02:04:08 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:04:08 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 3)) 02:04:08 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:04:08 INFO - Cleaning up... 02:04:08 INFO - Return code: 0 02:04:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:04: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')]} 02:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04: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')]} 02:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f68fdac8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd51240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', '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 02:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 02:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:04:08 INFO - Using env: {'DISPLAY': ':0', 02:04:08 INFO - 'HOME': '/home/cltbld', 02:04:08 INFO - 'LANG': 'en_US.UTF-8', 02:04:08 INFO - 'LANGUAGE': 'en_US:en', 02:04:08 INFO - 'LOGNAME': 'cltbld', 02:04:08 INFO - 'MAIL': '/var/mail/cltbld', 02:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:08 INFO - 'MOZ_NO_REMOTE': '1', 02:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:08 INFO - 'NO_EM_RESTART': '1', 02:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:08 INFO - 'PWD': '/builds/slave/test', 02:04:08 INFO - 'SHELL': '/bin/bash', 02:04:08 INFO - 'SHLVL': '1', 02:04:08 INFO - 'TERM': 'linux', 02:04:08 INFO - 'TMOUT': '86400', 02:04:08 INFO - 'USER': 'cltbld', 02:04:08 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:08 INFO - '_': '/tools/buildbot/bin/python'} 02:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:08 INFO - Downloading/unpacking jsonschema 02:04:08 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 02:04:08 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 02:04:08 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 02:04:08 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 02:04:08 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 02:04:08 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 02:04:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:04:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 02:04:10 INFO - Downloading/unpacking functools32 (from jsonschema) 02:04:10 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 02:04:10 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 02:04:10 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 02:04:10 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 02:04:10 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 02:04:10 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 02:04:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:04:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:04:10 INFO - warning: no files found matching '*.txt' 02:04:10 INFO - no previously-included directories found matching 'build' 02:04:10 INFO - no previously-included directories found matching 'dist' 02:04:10 INFO - no previously-included directories found matching '.git*' 02:04:10 INFO - Installing collected packages: jsonschema, functools32 02:04:10 INFO - Running setup.py install for functools32 02:04:10 INFO - warning: no files found matching '*.txt' 02:04:10 INFO - no previously-included directories found matching 'build' 02:04:10 INFO - no previously-included directories found matching 'dist' 02:04:10 INFO - no previously-included directories found matching '.git*' 02:04:10 INFO - Successfully installed jsonschema functools32 02:04:10 INFO - Cleaning up... 02:04:10 INFO - Return code: 0 02:04:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:04:10 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')]} 02:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:10 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')]} 02:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f68fdac8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd51240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', '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 02:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 02:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:04:10 INFO - Using env: {'DISPLAY': ':0', 02:04:10 INFO - 'HOME': '/home/cltbld', 02:04:10 INFO - 'LANG': 'en_US.UTF-8', 02:04:10 INFO - 'LANGUAGE': 'en_US:en', 02:04:10 INFO - 'LOGNAME': 'cltbld', 02:04:10 INFO - 'MAIL': '/var/mail/cltbld', 02:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:10 INFO - 'MOZ_NO_REMOTE': '1', 02:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:10 INFO - 'NO_EM_RESTART': '1', 02:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:10 INFO - 'PWD': '/builds/slave/test', 02:04:10 INFO - 'SHELL': '/bin/bash', 02:04:10 INFO - 'SHLVL': '1', 02:04:10 INFO - 'TERM': 'linux', 02:04:10 INFO - 'TMOUT': '86400', 02:04:10 INFO - 'USER': 'cltbld', 02:04:10 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:10 INFO - '_': '/tools/buildbot/bin/python'} 02:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:11 INFO - Downloading/unpacking flake8 02:04:11 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 02:04:11 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 02:04:11 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 02:04:11 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 02:04:11 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 02:04:11 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 02:04:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:04:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 02:04:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:04:12 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 02:04:12 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 02:04:12 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 02:04:12 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 02:04:12 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 02:04:12 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 02:04:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:04:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 02:04:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:04:12 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 02:04:12 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 02:04:12 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 02:04:12 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 02:04:12 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 02:04:12 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 02:04:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 02:04:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:04:13 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 02:04:13 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 02:04:13 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 02:04:13 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 02:04:13 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 02:04:13 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 02:04:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:04:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:04:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:04:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:04:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:04:13 INFO - no previously-included directories found matching 'docs/_build' 02:04:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:04:13 INFO - Running setup.py install for pep8 02:04:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:04:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:04:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:04:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:04:13 INFO - no previously-included directories found matching 'docs/_build' 02:04:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:04:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:04:13 INFO - Cleaning up... 02:04:13 INFO - Return code: 0 02:04:13 INFO - Running post-action listener: _resource_record_post_action 02:04:13 INFO - Running post-action listener: _start_resource_monitoring 02:04:13 INFO - Starting resource monitoring. 02:04:13 INFO - ##### 02:04:13 INFO - ##### Running install step. 02:04:13 INFO - ##### 02:04:13 INFO - Running pre-action listener: _resource_record_pre_action 02:04:13 INFO - Running main action method: install 02:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:04:13 INFO - Reading from file tmpfile_stdout 02:04:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:04:13 INFO - Reading from file tmpfile_stdout 02:04:13 INFO - Output received: 02:04:13 INFO - Usage: mozinstall [options] installer 02:04:13 INFO - Options: 02:04:13 INFO - -h, --help show this help message and exit 02:04:13 INFO - -d DEST, --destination=DEST 02:04:13 INFO - Directory to install application into. [default: 02:04:13 INFO - "/builds/slave/test"] 02:04:13 INFO - --app=APP Application being installed. [default: firefox] 02:04:13 INFO - mkdir: /builds/slave/test/build/application 02:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:04:29 INFO - Reading from file tmpfile_stdout 02:04:29 INFO - Output received: 02:04:29 INFO - /builds/slave/test/build/application/firefox/firefox 02:04:29 INFO - Running post-action listener: _resource_record_post_action 02:04:29 INFO - ##### 02:04:29 INFO - ##### Running run-tests step. 02:04:29 INFO - ##### 02:04:29 INFO - Running pre-action listener: _resource_record_pre_action 02:04:29 INFO - Running main action method: run_tests 02:04:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:04:29 INFO - Python 2.7.3 02:04:29 INFO - Return code: 0 02:04:29 INFO - grabbing minidump binary from tooltool 02:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:29 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 0xde00b0>, '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 0xde0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde1440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:04:29 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 02:04:29 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 02:04:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:04:29 INFO - Return code: 0 02:04:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:04:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:04:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:04:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:04:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:04:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:04:30 INFO - Return code: 0 02:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test/build 02:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 02:04:30 INFO - Using env: {'DISPLAY': ':0', 02:04:30 INFO - 'HOME': '/home/cltbld', 02:04:30 INFO - 'LANG': 'en_US.UTF-8', 02:04:30 INFO - 'LANGUAGE': 'en_US:en', 02:04:30 INFO - 'LOGNAME': 'cltbld', 02:04:30 INFO - 'MAIL': '/var/mail/cltbld', 02:04:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:04:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:30 INFO - 'MOZ_NO_REMOTE': '1', 02:04:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:30 INFO - 'NO_EM_RESTART': '1', 02:04:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:30 INFO - 'PWD': '/builds/slave/test', 02:04:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:04:30 INFO - 'SHELL': '/bin/bash', 02:04:30 INFO - 'SHLVL': '1', 02:04:30 INFO - 'TERM': 'linux', 02:04:30 INFO - 'TMOUT': '86400', 02:04:30 INFO - 'USER': 'cltbld', 02:04:30 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039', 02:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:30 INFO - '_': '/tools/buildbot/bin/python'} 02:04:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 02:04:30 INFO - mozversion INFO | application_buildid: 20151218011655 02:04:30 INFO - mozversion INFO | application_changeset: b32c4163ff05bd0293aa4e1cebc6636aaef60e1c 02:04:30 INFO - mozversion INFO | application_display_name: Nightly 02:04:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:04:30 INFO - mozversion INFO | application_name: Firefox 02:04:30 INFO - mozversion INFO | application_remotingname: firefox 02:04:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:04:30 INFO - mozversion INFO | application_vendor: Mozilla 02:04:30 INFO - mozversion INFO | application_version: 46.0a1 02:04:30 INFO - mozversion INFO | platform_buildid: 20151218011655 02:04:30 INFO - mozversion INFO | platform_changeset: b32c4163ff05bd0293aa4e1cebc6636aaef60e1c 02:04:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:04:30 INFO - mozversion INFO | platform_version: 46.0a1 02:04:30 INFO - 2015-12-18 02:04:30,522 DEBUG : using testdate: 1450433070 02:04:30 INFO - 2015-12-18 02:04:30,522 DEBUG : actual date: 1450433070 02:04:30 INFO - 2015-12-18 02:04:30,569 INFO : starting webserver on 'localhost:34504' 02:04:30 INFO - 2015-12-18 02:04:30,570 INFO : Starting test suite talos-linux64-ix-034.e 02:04:30 INFO - 2015-12-18 02:04:30,571 INFO : Starting test dromaeo_css 02:04:30 INFO - 2015-12-18 02:04:30,571 DEBUG : operating with platform_type : linux_ 02:04:30 INFO - 2015-12-18 02:04:30,571 INFO : Initialising browser for dromaeo_css test... 02:04:30 INFO - 2015-12-18 02:04:30,586 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6TgYQ/profile http://localhost:34504/getInfo.html 02:04:36 INFO - 2015-12-18 02:04:36,415 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:04:36 INFO - 2015-12-18 02:04:36,416 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:04:36 INFO - 2015-12-18 02:04:36,416 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:04:36 INFO - 2015-12-18 02:04:36,416 DEBUG : BROWSER_OUTPUT: __metrics 02:04:36 INFO - 2015-12-18 02:04:36,573 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:04:37 INFO - 2015-12-18 02:04:37,597 INFO : Browser initialized. 02:04:37 INFO - 2015-12-18 02:04:37,597 INFO : Running cycle 1/1 for dromaeo_css test... 02:04:37 INFO - 2015-12-18 02:04:37,597 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6TgYQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:04:49 INFO - 2015-12-18 02:04:49,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 150556672 02:04:49 INFO - 2015-12-18 02:04:49,621 DEBUG : BROWSER_OUTPUT: 02:05:39 INFO - 2015-12-18 02:05:39,259 DEBUG : BROWSER_OUTPUT: 1450433139258 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] 02:07:51 INFO - 2015-12-18 02:07:51,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34504/tests/dromaeo/cssquery-ext.html) 02:07:52 INFO - 2015-12-18 02:07:52,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 153198592 02:07:52 INFO - 2015-12-18 02:07:52,244 DEBUG : BROWSER_OUTPUT: 02:10:54 INFO - 2015-12-18 02:10:54,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/dromaeo/cssquery-ext.html (next: http://localhost:34504/tests/dromaeo/cssquery-jquery.html) 02:10:54 INFO - 2015-12-18 02:10:54,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 151732224 02:10:54 INFO - 2015-12-18 02:10:54,768 DEBUG : BROWSER_OUTPUT: 02:13:56 INFO - 2015-12-18 02:13:56,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34504/tests/dromaeo/cssquery-mootools.html) 02:13:57 INFO - 2015-12-18 02:13:57,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 155271168 02:13:57 INFO - 2015-12-18 02:13:57,175 DEBUG : BROWSER_OUTPUT: 02:16:58 INFO - 2015-12-18 02:16:58,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34504/tests/dromaeo/cssquery-prototype.html) 02:16:59 INFO - 2015-12-18 02:16:59,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 152616960 02:16:59 INFO - 2015-12-18 02:16:59,558 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-18 02:20:02,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34504/tests/dromaeo/cssquery-yui.html) 02:20:02 INFO - 2015-12-18 02:20:02,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 152416256 02:20:02 INFO - 2015-12-18 02:20:02,882 DEBUG : BROWSER_OUTPUT: 02:23:05 INFO - 2015-12-18 02:23:05,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/dromaeo/cssquery-yui.html (next: http://localhost:34504/tests/dromaeo/cssquery-dojo.html) 02:23:05 INFO - 2015-12-18 02:23:05,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 155172864 02:23:05 INFO - 2015-12-18 02:23:05,484 DEBUG : BROWSER_OUTPUT: 02:23:05 INFO - 2015-12-18 02:23:05,486 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:23:05 INFO - 2015-12-18 02:23:05,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:23:05 INFO - 2015-12-18 02:23:05,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:23:05 INFO - 2015-12-18 02:23:05,486 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:23:05 INFO - 2015-12-18 02:23:05,490 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2686.6373039639648;2702.6216329713857;2712.0914493644627;2750.5186592346336;2766.5850122481634;4585.862424127273;4716.221823399139;4742.217534106872;4742.312364707115;4745.145873742725;4646.744429056401;4738.052389522092;4747.359106520618;4753.928691069628;4767.213409787381;4185.602367775056;4446.155230506193;4455.264881294583;4467.508574056851;4533.546645335473;4250.2562051641;4475.709078909877;4540.250858608326;4551.089782043588;4551.135284295973;4306.720063195898;4320.049589090395;4387.890302742457;4425.557444255581;4444.333349997494;4425.513193548707;4425.557444255549;4435.090806384684;4481.798319075617;4493.168763778712;4154.937675934863;4326.805293761789;4422.15978963999;4423.469183697945;4457.799399027019;4616.169089563878;4655.86032419028;4758.3100450434495;4786.832460863853;4793.568578827887;5133.589312854962;5145.073886700392;5148.845534633967;5154.871128221787;5165.251038599419;4945.258211268302;5066.620003499752;5180.456052114511;5193.8961220775755;5200.557952574036;4755.262934245197;4801.903961920742;4812.759362031885;4834.734089625104;4890.217565189552;5296.602754793406;5298.0463516566615;5306.92039619406;5309.920351194735;5329.600279979017;4813.181759100961;4926.113299606105;4965.925511117336;5086.92369614456;5090.03289375025;5164.690118592896;5171.5862730981435;5188.273641690166;5192.636515443883;5195.090859099642;5067.8986420271385;5072.873178170576;5117.769700363493;5124.128898087334;5157.690538567698;4806.134895718735;4911.214205727138;4939.678920870132;5053.797848086036;5083.491650834887;4259.2759230930815;4262.957370426318;4278.743275403485;4281.828726850953;4311.719738217006;3756.8121593920196;3756.849726010929;3784.3566593679143;3785.299719551892;3801.163743976321;4181.644560212416;4291.0559676871035;4326.58897404746;4409.647228221735;4417.889552761207;5122.641415100908;5142.382914050338;5146.742662866916;5163.457836927144;5193.221016847503;4403.669724770655;4409.316555933835;4413.7351758894565;4417.867463976086;4450.020995381011;4358.8038538265855;4444.6666500012625;4458.108378324348;4531.614812740888;4560.201964656172;4861.683990540603;4887.60899128076;4898.681585696918;4903.068417000758;4961.255811628284;4854.393200849894;5180.585553155664;5198.714070726146;5215.608829337739;5249.002689488985;4769.523047695203;4802;4840.6127509798425;4856.247281671346;4893.73084480357;5093.414257360451;5128.974355128201;5133.332666753298;5152.3044389007;5182.714950677598;4911.557959783637;5055.140626093499;5182.585393168612;5189.091908916;5232.764525596282;4900.94629654626;4957.454679985271;4987.650864439454;4996.900061998667;5019.472955339636;4990.476000019946;5009.248612707977;5028.874278143076;5037.345145131109;5077.416097148875;4662.650301227353;4746.928796067993;4754.667173297836;4901.9264711028645;4990.525900039491;5003.4246061701915;5012.022655582126;5033;5038.319826823478;5068.417132029864;4874.78063487151;4907.631927605516;4923.286123512143;4924.015196960694;4965.47862474435 02:23:05 INFO - 2015-12-18 02:23:05,493 DEBUG : BROWSER_OUTPUT: |1;ext.html;517.6040329148202;536.340301429242;542.192133720756;545.9290292262007;552.4365147549502;25167.874160629195;32477.188070298253;32606.510902336486;32846.83576582114;32879.1780205495;39439.80280098603;39567.010824729325;39568;39672.60327396725;39807.80096099523;7817.648205830751;7966.561839098877;8031.196880311952;8036.07585127712;8055.436119471639;7880;7967.482113662593;7990.680372785082;7994.880076798852;8020.238077382639;7964.761057168265;8058.35533157346;8079.111297757242;8092.757217283491;8104.230098140667;7931.24653157952;7972.1629228931;8011.439199256054;8024.43828931975;8037.03555573335;7726.497777644435;7819.569923654197;7820.257075577811;7876.094249161305;7910.80222994424;36749.44875826865;37024;37061.44407833885;37216.627833721584;37280;2861.699521550228;2913.5047042002698;2954.069468117558;3158.7946783459233;3380.2056516718553;27553.724462755315;27909.441811163866;28347;28460.719267633005;29200.70799292001;3380.2732562201045;3414.8463319150696;3418.453047512386;3468.2369878626914;3540.0972751948348;210011;211527;211959;212019;212699;47524;47963.280550791766;54767.178492322644;55085;56939.430605694244;49602.75198624056;49775.502244977084;49781;49972.75013624909;50068.49931500711;13201.339933003503;13288.402021908843;13341.466341346237;13347.46610135603;13438.260895650637;9343.018983006823;9344.392614480174;9367.953160234156;9404.435733855991;9444.8583271251;18828.341008064654;19464.416067517996;19559.217631294872;19567.119479623452;19593;7213.944025952578;7478.775636730907;7492.325690687864;7516.436267279976;7605.125410577854;894.6376717429451;896.1755185229605;918.995405022984;984.4880662055691;1041.3959903256093;26569.07008254702;26584.06955756539;26646;26738.19785406441;28785.56821647677;929.5816882402811;933.1601558597181;974.0697633759743;1075.1291453922347;1076.6985244131656;13207.60377188686;13336.733265334833;13381.19712817234;13412.798808017887;13517.52688655912;263784;266861;267785;268344;269202;45785.7710711451;46191.30713039307;46280.30579541309;46433.30350044752;46478.30282545764;1242.3974372429363;1245.2590708528412;1262.8737126287115;1263.6019653809021;1266.7656483550572;24734.505309893342;24827.62758558587;25293.873530632965;25483.745162548137;25506.48987020212;40948.38577421401;41029.1794164121;41468;41518.377224342265;41536.584634153274;255802;256262;256470;259754;260565;27848.16455506338;28981.406022668954;29194.76675882028;29266.122016339545;29540.556891646214;33294.16764580905;33694.49458258079;33719.49420758642;33837;33868.53012913563;27554.724452755217;31219;32530;32580.837095814368;32957.17607059843;29565.704342956295;30099.849500752356;32435.18912027124;32659;32763.180920477178;31931.36137277288;32228.35543289168;32334.35331293408;32560.67439325671;32611.858584949412;28063.859680701466;29441.55837662394;29635.407291854473;30050.849745751133;30187.396252075276;22743.431414214778;23101.88449057744;23381.41546461352;23445.413864652837;23469.295921122393 02:23:05 INFO - 2015-12-18 02:23:05,493 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.9206394433364;324.595878131726;326.00964198213853;327.21958129860275;331.5739275031585;14980.176090315028;15419.69160616787;16072.919635401806;16149.031058136505;16648.916755416205;15094.320755566;15100.942933994598;15141.167235802026;15164.469243576477;15275.236238188074;4769.809207631691;5185.507376799198;5191.896162076775;5194.091034069042;5199.272101905736;5111.565516931047;5140.8971820563565;5152.046871328797;5170.043541944752;5172.896542069157;4534.070515544306;4800.615950723934;4895.9755201224125;5012.198048312271;5036.672616279949;5058.721770302632;5073.0361231366105;5087.9569688214015;5090.312807770978;5092.439831618519;5166.302549155854;5194.844154675328;5197.272381866542;5200.97399513;5206.349206349207;18060.548486287815;18245.63508729818;18385.080745962783;18838.71741923872;18890.62218755617;1875.784284807251;1882.9623407531772;1886.9056547172586;1886.9716954245698;1965.4693232827058;8347.207015333533;8794.296456283546;8924;10158.550171082989;12087.456064477119;1726.4302780082542;1729.7751292332043;1738.4593312324048;1744.485376813843;1747.5718448979953;48138.75930620325;49237.50762492401;49269.26096108561;49662.50337496651;50260.74869625665;9552.474613896164;9818.852717209247;9865.358751681119;9867.210623150131;9910.653127140515;12235.449404776806;12371.443285052193;12400;12418.068644851672;12443.315617641116;7187.029750983655;7195.496315257987;7225.313595208447;7283.417326613858;7322.1579518355;7078.646067696594;7129.073220481304;7130.322619351154;7145.606991615407;7145.821354466076;4098.057446787256;4111.732737372121;4121.072758629344;4123.546409894909;4199.160167966419;1695.482877722282;1707.5304291319737;1718.312674930038;1728.5073753980055;1750.64111857069;388.47749776550495;760.6691089376139;882.6160620130264;918.6417297253943;1001.1690297053574;9252.768680783034;9747.707568772948;9821.459819709984;10007.249456290807;10088.646897358703;401.22657852292934;407.6473850119684;408.9488813898263;415.08266730525276;439.16777706246484;5332.093544097513;5450.454954504517;5460.399356070829;5515.200295957064;5540.9168862467095;449685;452284;465123;469158;473718;77330;77782;78035.60982195166;78437.60781196172;80488.59755701185;444.6109654052704;446.72749622730106;449.4000509320029;449.8290649553149;451.0775464175834;9219.308551858772;9222.985471598253;9249.630014799603;9268.119528644767;9348.065193480597;29773.404531909673;30744.84627576848;31261.37477250397;31557.8422107888;31916.5212521817;44704.77647611741;45842.312365315214;47227;47648.761756190994;49133;8816.647334106563;8817.647294108165;8916.73249802507;8961.059088795582;8978.730638080868;16296.348146074024;16461.34154633801;16864.747028794824;16878.915605421895;16906.492805215865;13056.412461439448;13508.18950862912;13929.164250145024;13992.16047037181;14418.639534011734;13293.335333233494;13514.324283785574;13562.525311614441;13959.022868399115;14039.649008774453;10729.570817167227;14236.946388109942;14391.712165756417;14527.92736036313;14551.636209094857;8926.642934282556;8980.506072166094;9020.278377729635;9167.954160229156;9182.17360437564;13683.726325473634;13810.37853296584;14104.506342277971;14286.285685715466;14365.209913454442 02:23:05 INFO - 2015-12-18 02:23:05,495 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1452.3464441001552;1636.2882146266375;1675.3131216201352;1688.3499852556763;1703.6933351996636;6868.62222577758;6923.826904327394;7095.964520177392;7156.105486814148;7196.532225405345;7164.391026762732;7210.242924492932;7242.31198036187;7272.4909256352075;7285.817854553638;2039.8062184092526;2070.6479898417306;2082.3856962196114;2083.499960009602;2089.268755935426;2038.1337931379178;2075.1595603780493;2075.543380456297;2095.717078194447;2097.800708932649;1697.8811483196182;1708.419137493252;1898.117375420436;2012.044278967486;2048.8770673759623;1969.7537807774029;1972.9112189951416;1974.9802501974941;1975.9604807903904;1981.6829307310904;1988.4531753767685;1992.5815578728484;2048.7439070116234;2057.2593866208153;2061.0828181459256;7069.222385537587;7079.362857342812;7087.681054352566;7122.821929451753;7153.105861767279;3951.38753493209;4086.5300490443383;4094.2016306820183;4115.629593336614;4122.2579935611575;2602.141293373182;2624.5013447445117;2647.5896236083436;2694.0840114361213;2694.0974773450916;888.8133491966695;892.1212605583495;896.9058248883904;897.6364572348209;918.7932715139107;9293.907060929372;9420.19928306088;9442.527873606292;9461.763455913657;9501.90498095024;3588.8026158561006;3649.799261040615;3654.7076233901225;3658.7804731716183;3703.407454807218;7665.61671916402;7689.346405555479;7694.653740581687;7730;7755.495892766952;4026.899327516777;4035.3139966205817;4045.0494133878515;4048.3117869962175;4068.4100805383646;3685.576158741779;3697.2975134724315;3697.6856967157555;3700;3704.555453345562;3078.2150551609643;3083.768717346208;3083.92290192747;3094.4584697677815;3112.43976084307;886.3839631456076;900.6937641201891;901.1799262670938;905.9637614495479;906.2432868554699;899.1278459893892;900.6532484993194;907.3059109781022;1053.331134729437;1072.9463526823627;6429.196350456193;6450.322716114741;6484.416402523795;6487;6489.1888513935755;568.7980766827799;573.9024365857814;582.8571999860061;586.0418216216517;719.8230892490815;5049.419316778544;5101.821436249714;5129.538341549204;5134.7946082156295;5139.203423469368;7808.921910780819;8147.348212143014;8191.631376588068;8218.342532597379;8286.792830179173;8057.234562716532;8078.3133433658795;8090.1909809018625;8109.026916769907;8160.143184965493;6215.564910456315;6385.904211436832;6408.903866442007;6414.486841052704;6428.003659432796;6146.815595532141;6154.476869465966;6167.660778657217;6173.043178307369;6180.103884936749;7169.605671687898;7253.1296244451005;7307.634618268959;7358.705651773869;7404.222556631692;7555.773326800205;7559.28186822251;7584;7676.462647614837;7691.384689224737;5777.075667893117;5777.508911742549;5809.883802323845;5848.561357898089;5895.7052147391605;6635.8009259722285;6711.932880671131;6738.124043874265;6750.29121942189;6770.763023294161;6438.806835794933;6563.409293163638;6574.868502630016;6614.768483103068;6687.230968438692;6292.622442653455;6426.550141490238;6429.292777794532;6495.837604059747;6565;6272.8118156455375;6499.057636642755;6506.089147519446;6509.609423434609;6532.216134063943;5935.673537955454;5972.343042265435;5990.041593345044;6014.0678194879865;6026.517878569792;5764.452377024176;5805.332386775575;5825.766969321349;5828.446297601721;5843.065109582446 02:23:05 INFO - 2015-12-18 02:23:05,496 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.6319382368951;303.6659674358206;304.1301876632829;311.8088900400471;312.36589722862595;5444.346678398593;5508.173773933912;5561.304836895388;5578.888422231558;5688.459596338352;5495.395506494282;5497.615166938306;5524.226608274845;5547.306586676666;5565.053940830058;4270.188664153817;4270.423492828475;4283.614474697277;4286.357046443043;4292.270314046604;4285.400043993844;4289.077848262623;4291.270484017725;4292.806823692941;4305.160493703729;4091.713580049398;4217.051163488206;4225;4251.06476575153;4257.04216551275;4169.97915010426;4208.852690155861;4212.452381190456;4214.304639734441;4225.281702110648;3658.743887927846;3663.6519530644546;3663.7984910829896;3668.046307959923;3670.614585468514;5306.097963346202;5307.442718514578;5314.176302673091;5314.362276526803;5329.920051199235;4777.474477807438;4781.737004464753;4807.495213002654;4813.326134341195;4821.915069109457;5765.88468230633;5799.101139323411;5810.709464526757;5813.273340832396;5814.273215848019;4084.5098588169312;4086.5300490443383;4086.59134086589;4091.590840915914;4097.795110244476;6051.425114614105;6121.571489995702;6127.816165515042;6139.355367686373;6142;4034.677225821927;4156.854510092132;4173.4157217989505;4175.434212170436;4197.601227883346;4220.451341325608;4225.133847561243;4227.682923780729;4229.407882896397;4235.195312890541;4863;4863.443698016601;4871.707697538159;4876.097921884463;4877.6829506081995;5802.912956305659;5827.446392592697;5833.183354330397;5843.1235314703135;5843.386444423274;1487.9851201488063;1493.6415260337442;1496.8203815542204;1497.176552895903;1528.3198976455592;1028.0850043461326;1051.64244156987;1058.2856571813995;1061.766411389493;1069.7058308965097;4987.376577927759;4999.800007999712;5019.0965626187635;5020.799168033311;5023.070731914608;5891;5915.526757859361;5935;5944.048952167633;5958.165856780054;4944.184209605375;4974.825881094217;4977.726225057584;4995.925061124086;5020.7740651670765;3160.652328243891;3199.472087105648;3207.0699497146034;3214.067920303086;3227.064151396116;5579.609427340129;5584.218209450599;5599.44005599445;5600.775968961196;5619.353774315924;6068.4841788448475;6092.147099406086;6104;6118.847028824315;6139.2325959255095;5468.644538105011;5589.496945274864;5589.972050139723;5602.187682786055;5602.887942241214;5929.52563794904;5949;5951.047832346804;5959.046552551571;5971.671558064349;5798.913016304675;5805.129230615442;5809.854753631024;5810.709464526842;5831.620944638585;5602.579806514446;5605.1872478491205;5611.158326251095;5612.803551875665;5631.986242476393;4131.586841315844;4194.727342722713;4216.24107660624;4267.317229243306;4269.359596060615;5942.465178133989;5951.494122999594;5957.6127551709;5962.2249107615735;5962.940370596412;5802.65184088956;5806.82579522615;5876.059830427112;5877.588568800143;5880.8235752927485;5833.154192642128;5860.326062502696;5861.648301101947;5865.208196893364;5870.090136028923;5620.353659329229;5737.225474560881;5737.885242295214;5751.367349591458;5751.597388182787;5885.176075349369;5886.911696324473;5892.027815410581;5894.6757928314355;5900.940990590039;5675.290588676416;5695.345035320991;5711.543076553782;5751;5758.798442054508 02:23:05 INFO - 2015-12-18 02:23:05,497 DEBUG : BROWSER_OUTPUT: |5;yui.html;576.7318197038377;603.2851071480296;676.3000294694986;697.2574208467983;699.4369532526316;10429.478526073704;10618.946905265473;10631.202659800518;10637.095846853008;10711.625093121742;10728.946355268212;12498.062645301594;12681.54162271339;12731.299778512179;12745.235285882853;770.9383249340053;778.7040924448702;785.1677222144516;785.4541093939714;792.4175730837829;797.0674311056049;800.4716886854677;801.1027649033063;802.8233788566536;806.8265322955564;826.7643721539363;835.2524490580927;837.0624900111883;837.2966707965307;837.4891316297054;818.2145140664969;820.885076089348;822.6051495282268;823.8928939237891;824.2622852546997;616.3282022595348;616.374380004296;616.7193926763312;619.1393962392278;621.2420846567181;11728.765424691544;11764.588239411665;11824.704382390422;11844.052475801915;11848.28910265387;10527.21045921559;10745.08666763326;10863.619773307897;10887.891121088767;11244.325340479598;8878.378513504058;9106.86339704905;9345;9378.624855005792;9532.761680958032;3145.1665308693214;3151.07043422191;3201;3228.2413632796274;3288.523164141186;38274.80862595669;38292.80853595742;38305.23389532194;38406.80796596027;38533.22933541313;8815.162559556831;8892.555372231363;9110.088991100969;9128.817423651622;9146.588403521857;15396.615084622974;15460.845391546165;15586.844131558766;15606.453774117852;15629.921850390676;6193.628382297076;6228.750849965951;6338.112664227012;6378.107065010902;6439;3398.8300584970652;3486.825658717054;3543.3976224041457;3555.3422616815456;3565.4830049642655;2499.3251822007956;2508.8243822932586;2525.6590360301125;2537.403710128155;2547.210364786922;440.47363400735816;441.86743976806827;443.1978119603528;449.16679559417463;449.2721790699088;399.2115571745779;426.6821218192467;430.15045285561393;441.111161010564;458.3056669146246;6753.392194702402;7099.609521476368;7710.537367757953;7773.3004029637605;8153.306968907709;450.1582041582197;460.1441319146385;492.7856382473635;496.09957926363535;518.440084708514;3172.666869978665;3295.8681652734103;3342.19787251058;3367.8316084195694;3433.7939723616664;49575.752121239166;49933;49967.750161249685;55701.44298557044;55811.72094139503;43306;44078.55921440809;44236.11527769427;44316;44353.77823110864;40468.797656011535;40541.59458405437;40860;40941.79529102395;40966.180676386306;7227.205007449282;7279.636018199175;7663.348615367533;7712.652930618248;7911.485753426009;28374.85812570924;29018;29146.854265728536;29154.708452915198;31613.683863161074;39293;39564.80217598894;39596.40605390979;39863;40139.59860401358;9451;9635.951820240854;9739.172170365599;9789.412635241908;9861.901380986385;10824.296420732628;10950.06924411434;10994.394272798922;11260.099192064452;11435.313881167156;9385.436873787594;9565.139137477661;9810.068043535854;9893.703188904345;9897.257705672248;9640.42157470554;9654.131128198496;9684.32209745311;9826;10120.595176193165;9954.601815927283;10096.242781791541;10264.64073757415;10345.224108192066;10593.629222977159;8241.340692744687;8383.95808020956;8387.622556984828;8474.855564932095;8786.956065219632;8347.749567512985;8585.613647385757;8651.52416617092;8672.219500245008;8829.426087304304 02:23:05 INFO - 2015-12-18 02:23:05,497 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:23:05 INFO - 2015-12-18 02:23:05,497 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:23:05 INFO - 2015-12-18 02:23:05,497 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,332 02:23:05 INFO - 2015-12-18 02:23:05,497 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:23:05 INFO - 2015-12-18 02:23:05,499 DEBUG : BROWSER_OUTPUT: __startTimestamp1450434185485__endTimestamp 02:23:05 INFO - 2015-12-18 02:23:05,499 DEBUG : BROWSER_OUTPUT: 02:23:05 INFO - 2015-12-18 02:23:05,499 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:23:05 INFO - 2015-12-18 02:23:05,499 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:23:05 INFO - 2015-12-18 02:23:05,499 DEBUG : BROWSER_OUTPUT: 02:23:05 INFO - 2015-12-18 02:23:05,499 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4724.07 Median:4854.39 stddev:501.23 (10.3%) stddev-sans-first:476.60 02:23:05 INFO - 2015-12-18 02:23:05,499 DEBUG : BROWSER_OUTPUT: Values: 2686.6 2702.6 2712.1 2750.5 2766.6 4585.9 4716.2 4742.2 4742.3 4745.1 4646.7 4738.1 4747.4 4753.9 4767.2 4185.6 4446.2 4455.3 4467.5 4533.5 4250.3 4475.7 4540.3 4551.1 4551.1 4306.7 4320.0 4387.9 4425.6 4444.3 4425.5 4425.6 4435.1 4481.8 4493.2 4154.9 4326.8 4422.2 4423.5 4457.8 4616.2 4655.9 4758.3 4786.8 4793.6 5133.6 5145.1 5148.8 5154.9 5165.3 4945.3 5066.6 5180.5 5193.9 5200.6 4755.3 4801.9 4812.8 4834.7 4890.2 5296.6 5298.0 5306.9 5309.9 5329.6 4813.2 4926.1 4965.9 5086.9 5090.0 5164.7 5171.6 5188.3 5192.6 5195.1 5067.9 5072.9 5117.8 5124.1 5157.7 4806.1 4911.2 4939.7 5053.8 5083.5 4259.3 4263.0 4278.7 4281.8 4311.7 3756.8 3756.8 3784.4 3785.3 3801.2 4181.6 4291.1 4326.6 4409.6 4417.9 5122.6 5142.4 5146.7 5163.5 5193.2 4403.7 4409.3 4413.7 4417.9 4450.0 4358.8 4444.7 4458.1 4531.6 4560.2 4861.7 4887.6 4898.7 4903.1 4961.3 4854.4 5180.6 5198.7 5215.6 5249.0 4769.5 4802.0 4840.6 4856.2 4893.7 5093.4 5129.0 5133.3 5152.3 5182.7 4911.6 5055.1 5182.6 5189.1 5232.8 4900.9 4957.5 4987.7 4996.9 5019.5 4990.5 5009.2 5028.9 5037.3 5077.4 4662.7 4746.9 4754.7 4901.9 4990.5 5003.4 5012.0 5033.0 5038.3 5068.4 4874.8 4907.6 4923.3 4924.0 4965.5 02:23:05 INFO - 2015-12-18 02:23:05,499 DEBUG : BROWSER_OUTPUT: 02:23:05 INFO - 2015-12-18 02:23:05,499 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39955.94 Median:32918.18 stddev:64293.33 (195.3%) stddev-sans-first:64405.50 02:23:05 INFO - 2015-12-18 02:23:05,500 DEBUG : BROWSER_OUTPUT: Values: 517.6 536.3 542.2 545.9 552.4 25167.9 32477.2 32606.5 32846.8 32879.2 39439.8 39567.0 39568.0 39672.6 39807.8 7817.6 7966.6 8031.2 8036.1 8055.4 7880.0 7967.5 7990.7 7994.9 8020.2 7964.8 8058.4 8079.1 8092.8 8104.2 7931.2 7972.2 8011.4 8024.4 8037.0 7726.5 7819.6 7820.3 7876.1 7910.8 36749.4 37024.0 37061.4 37216.6 37280.0 2861.7 2913.5 2954.1 3158.8 3380.2 27553.7 27909.4 28347.0 28460.7 29200.7 3380.3 3414.8 3418.5 3468.2 3540.1 210011.0 211527.0 211959.0 212019.0 212699.0 47524.0 47963.3 54767.2 55085.0 56939.4 49602.8 49775.5 49781.0 49972.8 50068.5 13201.3 13288.4 13341.5 13347.5 13438.3 9343.0 9344.4 9368.0 9404.4 9444.9 18828.3 19464.4 19559.2 19567.1 19593.0 7213.9 7478.8 7492.3 7516.4 7605.1 894.6 896.2 919.0 984.5 1041.4 26569.1 26584.1 26646.0 26738.2 28785.6 929.6 933.2 974.1 1075.1 1076.7 13207.6 13336.7 13381.2 13412.8 13517.5 263784.0 266861.0 267785.0 268344.0 269202.0 45785.8 46191.3 46280.3 46433.3 46478.3 1242.4 1245.3 1262.9 1263.6 1266.8 24734.5 24827.6 25293.9 25483.7 25506.5 40948.4 41029.2 41468.0 41518.4 41536.6 255802.0 256262.0 256470.0 259754.0 260565.0 27848.2 28981.4 29194.8 29266.1 29540.6 33294.2 33694.5 33719.5 33837.0 33868.5 27554.7 31219.0 32530.0 32580.8 32957.2 29565.7 30099.8 32435.2 32659.0 32763.2 31931.4 32228.4 32334.4 32560.7 32611.9 28063.9 29441.6 29635.4 30050.8 30187.4 22743.4 23101.9 23381.4 23445.4 23469.3 02:23:05 INFO - 2015-12-18 02:23:05,500 DEBUG : BROWSER_OUTPUT: 02:23:05 INFO - 2015-12-18 02:23:05,500 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25404.78 Median:225067.41 stddev:75650.87 (33.6%) stddev-sans-first:75839.65 02:23:05 INFO - 2015-12-18 02:23:05,501 DEBUG : BROWSER_OUTPUT: Values: 323.9 324.6 326.0 327.2 331.6 14980.2 15419.7 16072.9 16149.0 16648.9 15094.3 15100.9 15141.2 15164.5 15275.2 4769.8 5185.5 5191.9 5194.1 5199.3 5111.6 5140.9 5152.0 5170.0 5172.9 4534.1 4800.6 4896.0 5012.2 5036.7 5058.7 5073.0 5088.0 5090.3 5092.4 5166.3 5194.8 5197.3 5201.0 5206.3 18060.5 18245.6 18385.1 18838.7 18890.6 1875.8 1883.0 1886.9 1887.0 1965.5 8347.2 8794.3 8924.0 10158.6 12087.5 1726.4 1729.8 1738.5 1744.5 1747.6 48138.8 49237.5 49269.3 49662.5 50260.7 9552.5 9818.9 9865.4 9867.2 9910.7 12235.4 12371.4 12400.0 12418.1 12443.3 7187.0 7195.5 7225.3 7283.4 7322.2 7078.6 7129.1 7130.3 7145.6 7145.8 4098.1 4111.7 4121.1 4123.5 4199.2 1695.5 1707.5 1718.3 1728.5 1750.6 388.5 760.7 882.6 918.6 1001.2 9252.8 9747.7 9821.5 10007.2 10088.6 401.2 407.6 408.9 415.1 439.2 5332.1 5450.5 5460.4 5515.2 5540.9 449685.0 452284.0 465123.0 469158.0 473718.0 77330.0 77782.0 78035.6 78437.6 80488.6 444.6 446.7 449.4 449.8 451.1 9219.3 9223.0 9249.6 9268.1 9348.1 29773.4 30744.8 31261.4 31557.8 31916.5 44704.8 45842.3 47227.0 47648.8 49133.0 8816.6 8817.6 8916.7 8961.1 8978.7 16296.3 16461.3 16864.7 16878.9 16906.5 13056.4 13508.2 13929.2 13992.2 14418.6 13293.3 13514.3 13562.5 13959.0 14039.6 10729.6 14236.9 14391.7 14527.9 14551.6 8926.6 8980.5 9020.3 9168.0 9182.2 13683.7 13810.4 14104.5 14286.3 14365.2 02:23:05 INFO - 2015-12-18 02:23:05,501 DEBUG : BROWSER_OUTPUT: 02:23:05 INFO - 2015-12-18 02:23:05,501 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4828.85 Median:6197.83 stddev:2525.67 (40.8%) stddev-sans-first:2520.00 02:23:05 INFO - 2015-12-18 02:23:05,502 DEBUG : BROWSER_OUTPUT: Values: 1452.3 1636.3 1675.3 1688.3 1703.7 6868.6 6923.8 7096.0 7156.1 7196.5 7164.4 7210.2 7242.3 7272.5 7285.8 2039.8 2070.6 2082.4 2083.5 2089.3 2038.1 2075.2 2075.5 2095.7 2097.8 1697.9 1708.4 1898.1 2012.0 2048.9 1969.8 1972.9 1975.0 1976.0 1981.7 1988.5 1992.6 2048.7 2057.3 2061.1 7069.2 7079.4 7087.7 7122.8 7153.1 3951.4 4086.5 4094.2 4115.6 4122.3 2602.1 2624.5 2647.6 2694.1 2694.1 888.8 892.1 896.9 897.6 918.8 9293.9 9420.2 9442.5 9461.8 9501.9 3588.8 3649.8 3654.7 3658.8 3703.4 7665.6 7689.3 7694.7 7730.0 7755.5 4026.9 4035.3 4045.0 4048.3 4068.4 3685.6 3697.3 3697.7 3700.0 3704.6 3078.2 3083.8 3083.9 3094.5 3112.4 886.4 900.7 901.2 906.0 906.2 899.1 900.7 907.3 1053.3 1072.9 6429.2 6450.3 6484.4 6487.0 6489.2 568.8 573.9 582.9 586.0 719.8 5049.4 5101.8 5129.5 5134.8 5139.2 7808.9 8147.3 8191.6 8218.3 8286.8 8057.2 8078.3 8090.2 8109.0 8160.1 6215.6 6385.9 6408.9 6414.5 6428.0 6146.8 6154.5 6167.7 6173.0 6180.1 7169.6 7253.1 7307.6 7358.7 7404.2 7555.8 7559.3 7584.0 7676.5 7691.4 5777.1 5777.5 5809.9 5848.6 5895.7 6635.8 6711.9 6738.1 6750.3 6770.8 6438.8 6563.4 6574.9 6614.8 6687.2 6292.6 6426.6 6429.3 6495.8 6565.0 6272.8 6499.1 6506.1 6509.6 6532.2 5935.7 5972.3 5990.0 6014.1 6026.5 5764.5 5805.3 5825.8 5828.4 5843.1 02:23:05 INFO - 2015-12-18 02:23:05,502 DEBUG : BROWSER_OUTPUT: 02:23:05 INFO - 2015-12-18 02:23:05,502 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4799.20 Median:5456.50 stddev:1405.43 (25.8%) stddev-sans-first:1368.12 02:23:05 INFO - 2015-12-18 02:23:05,502 DEBUG : BROWSER_OUTPUT: Values: 295.6 303.7 304.1 311.8 312.4 5444.3 5508.2 5561.3 5578.9 5688.5 5495.4 5497.6 5524.2 5547.3 5565.1 4270.2 4270.4 4283.6 4286.4 4292.3 4285.4 4289.1 4291.3 4292.8 4305.2 4091.7 4217.1 4225.0 4251.1 4257.0 4170.0 4208.9 4212.5 4214.3 4225.3 3658.7 3663.7 3663.8 3668.0 3670.6 5306.1 5307.4 5314.2 5314.4 5329.9 4777.5 4781.7 4807.5 4813.3 4821.9 5765.9 5799.1 5810.7 5813.3 5814.3 4084.5 4086.5 4086.6 4091.6 4097.8 6051.4 6121.6 6127.8 6139.4 6142.0 4034.7 4156.9 4173.4 4175.4 4197.6 4220.5 4225.1 4227.7 4229.4 4235.2 4863.0 4863.4 4871.7 4876.1 4877.7 5802.9 5827.4 5833.2 5843.1 5843.4 1488.0 1493.6 1496.8 1497.2 1528.3 1028.1 1051.6 1058.3 1061.8 1069.7 4987.4 4999.8 5019.1 5020.8 5023.1 5891.0 5915.5 5935.0 5944.0 5958.2 4944.2 4974.8 4977.7 4995.9 5020.8 3160.7 3199.5 3207.1 3214.1 3227.1 5579.6 5584.2 5599.4 5600.8 5619.4 6068.5 6092.1 6104.0 6118.8 6139.2 5468.6 5589.5 5590.0 5602.2 5602.9 5929.5 5949.0 5951.0 5959.0 5971.7 5798.9 5805.1 5809.9 5810.7 5831.6 5602.6 5605.2 5611.2 5612.8 5632.0 4131.6 4194.7 4216.2 4267.3 4269.4 5942.5 5951.5 5957.6 5962.2 5962.9 5802.7 5806.8 5876.1 5877.6 5880.8 5833.2 5860.3 5861.6 5865.2 5870.1 5620.4 5737.2 5737.9 5751.4 5751.6 5885.2 5886.9 5892.0 5894.7 5900.9 5675.3 5695.3 5711.5 5751.0 5758.8 02:23:05 INFO - 2015-12-18 02:23:05,502 DEBUG : BROWSER_OUTPUT: 02:23:05 INFO - 2015-12-18 02:23:05,502 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11979.89 Median:459.22 stddev:13853.06 (3016.6%) stddev-sans-first:13865.45 02:23:05 INFO - 2015-12-18 02:23:05,504 DEBUG : BROWSER_OUTPUT: Values: 576.7 603.3 676.3 697.3 699.4 10429.5 10618.9 10631.2 10637.1 10711.6 10728.9 12498.1 12681.5 12731.3 12745.2 770.9 778.7 785.2 785.5 792.4 797.1 800.5 801.1 802.8 806.8 826.8 835.3 837.1 837.3 837.5 818.2 820.9 822.6 823.9 824.3 616.3 616.4 616.7 619.1 621.2 11728.8 11764.6 11824.7 11844.1 11848.3 10527.2 10745.1 10863.6 10887.9 11244.3 8878.4 9106.9 9345.0 9378.6 9532.8 3145.2 3151.1 3201.0 3228.2 3288.5 38274.8 38292.8 38305.2 38406.8 38533.2 8815.2 8892.6 9110.1 9128.8 9146.6 15396.6 15460.8 15586.8 15606.5 15629.9 6193.6 6228.8 6338.1 6378.1 6439.0 3398.8 3486.8 3543.4 3555.3 3565.5 2499.3 2508.8 2525.7 2537.4 2547.2 440.5 441.9 443.2 449.2 449.3 399.2 426.7 430.2 441.1 458.3 6753.4 7099.6 7710.5 7773.3 8153.3 450.2 460.1 492.8 496.1 518.4 3172.7 3295.9 3342.2 3367.8 3433.8 49575.8 49933.0 49967.8 55701.4 55811.7 43306.0 44078.6 44236.1 44316.0 44353.8 40468.8 40541.6 40860.0 40941.8 40966.2 7227.2 7279.6 7663.3 7712.7 7911.5 28374.9 29018.0 29146.9 29154.7 31613.7 39293.0 39564.8 39596.4 39863.0 40139.6 9451.0 9636.0 9739.2 9789.4 9861.9 10824.3 10950.1 10994.4 11260.1 11435.3 9385.4 9565.1 9810.1 9893.7 9897.3 9640.4 9654.1 9684.3 9826.0 10120.6 9954.6 10096.2 10264.6 10345.2 10593.6 8241.3 8384.0 8387.6 8474.9 8787.0 8347.7 8585.6 8651.5 8672.2 8829.4 02:23:05 INFO - 2015-12-18 02:23:05,504 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:23:05 INFO - 2015-12-18 02:23:05,504 DEBUG : BROWSER_OUTPUT: 02:23:06 INFO - 2015-12-18 02:23:06,189 INFO : Browser exited with error code: 0 02:23:06 INFO - 2015-12-18 02:23:06,208 INFO : Completed test dromaeo_css (00:18:35) 02:23:06 INFO - 2015-12-18 02:23:06,208 INFO : Starting test kraken 02:23:06 INFO - 2015-12-18 02:23:06,208 DEBUG : operating with platform_type : linux_ 02:23:06 INFO - 2015-12-18 02:23:06,208 INFO : Initialising browser for kraken test... 02:23:06 INFO - 2015-12-18 02:23:06,214 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBlzzxv/profile http://localhost:34504/getInfo.html 02:23:11 INFO - 2015-12-18 02:23:11,707 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:23:11 INFO - 2015-12-18 02:23:11,707 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:23:11 INFO - 2015-12-18 02:23:11,707 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:23:11 INFO - 2015-12-18 02:23:11,707 DEBUG : BROWSER_OUTPUT: __metrics 02:23:11 INFO - 2015-12-18 02:23:11,864 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:23:12 INFO - 2015-12-18 02:23:12,849 INFO : Browser initialized. 02:23:12 INFO - 2015-12-18 02:23:12,849 INFO : Running cycle 1/1 for kraken test... 02:23:12 INFO - 2015-12-18 02:23:12,849 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBlzzxv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:23:24 INFO - 2015-12-18 02:23:24,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 151089152 02:23:24 INFO - 2015-12-18 02:23:24,826 DEBUG : BROWSER_OUTPUT: 02:23:27 INFO - 2015-12-18 02:23:27,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34504/tests/kraken/driver.html?testName=audio-beat-detection) 02:23:28 INFO - 2015-12-18 02:23:28,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 152207360 02:23:28 INFO - 2015-12-18 02:23:28,039 DEBUG : BROWSER_OUTPUT: 02:23:30 INFO - 2015-12-18 02:23:30,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34504/tests/kraken/driver.html?testName=audio-dft) 02:23:31 INFO - 2015-12-18 02:23:31,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 151875584 02:23:31 INFO - 2015-12-18 02:23:31,337 DEBUG : BROWSER_OUTPUT: 02:23:34 INFO - 2015-12-18 02:23:34,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34504/tests/kraken/driver.html?testName=audio-fft) 02:23:34 INFO - 2015-12-18 02:23:34,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 145190912 02:23:34 INFO - 2015-12-18 02:23:34,823 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-12-18 02:23:36,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34504/tests/kraken/driver.html?testName=audio-oscillator) 02:23:37 INFO - 2015-12-18 02:23:37,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 146128896 02:23:37 INFO - 2015-12-18 02:23:37,490 DEBUG : BROWSER_OUTPUT: 02:23:39 INFO - 2015-12-18 02:23:39,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34504/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:23:40 INFO - 2015-12-18 02:23:40,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 146358272 02:23:40 INFO - 2015-12-18 02:23:40,346 DEBUG : BROWSER_OUTPUT: 02:23:43 INFO - 2015-12-18 02:23:43,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34504/tests/kraken/driver.html?testName=imaging-darkroom) 02:23:44 INFO - 2015-12-18 02:23:44,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 146755584 02:23:44 INFO - 2015-12-18 02:23:44,029 DEBUG : BROWSER_OUTPUT: 02:23:47 INFO - 2015-12-18 02:23:47,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34504/tests/kraken/driver.html?testName=imaging-desaturate) 02:23:48 INFO - 2015-12-18 02:23:48,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 147746816 02:23:48 INFO - 2015-12-18 02:23:48,078 DEBUG : BROWSER_OUTPUT: 02:23:51 INFO - 2015-12-18 02:23:51,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34504/tests/kraken/driver.html?testName=json-parse-financial) 02:23:51 INFO - 2015-12-18 02:23:51,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 148828160 02:23:51 INFO - 2015-12-18 02:23:51,606 DEBUG : BROWSER_OUTPUT: 02:23:53 INFO - 2015-12-18 02:23:53,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34504/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:23:53 INFO - 2015-12-18 02:23:53,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 148996096 02:23:53 INFO - 2015-12-18 02:23:53,954 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34504/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:23:56 INFO - 2015-12-18 02:23:56,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 148205568 02:23:56 INFO - 2015-12-18 02:23:56,460 DEBUG : BROWSER_OUTPUT: 02:23:58 INFO - 2015-12-18 02:23:58,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34504/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:23:59 INFO - 2015-12-18 02:23:59,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 148213760 02:23:59 INFO - 2015-12-18 02:23:59,225 DEBUG : BROWSER_OUTPUT: 02:24:01 INFO - 2015-12-18 02:24:01,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:24:02 INFO - 2015-12-18 02:24:02,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 148492288 02:24:02 INFO - 2015-12-18 02:24:02,417 DEBUG : BROWSER_OUTPUT: 02:24:05 INFO - 2015-12-18 02:24:05,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:24:05 INFO - 2015-12-18 02:24:05,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 148144128 02:24:05 INFO - 2015-12-18 02:24:05,640 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34504/tests/kraken/driver.html?testName=ai-astar) 02:24:07 INFO - 2015-12-18 02:24:07,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 149426176 02:24:07 INFO - 2015-12-18 02:24:07,652 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,655 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:24:07 INFO - 2015-12-18 02:24:07,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:24:07 INFO - 2015-12-18 02:24:07,656 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:24:07 INFO - 2015-12-18 02:24:07,656 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:24:07 INFO - 2015-12-18 02:24:07,656 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;112;114;114;125;112;115;114;114 02:24:07 INFO - 2015-12-18 02:24:07,656 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;131;155;169;131;149;151;133;167;137 02:24:07 INFO - 2015-12-18 02:24:07,656 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;161;162;164;164;168;173;165;163 02:24:07 INFO - 2015-12-18 02:24:07,656 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;72;72;80;73;135;75;77;75;79 02:24:07 INFO - 2015-12-18 02:24:07,656 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;137;95;96;94;137;94;95;135 02:24:07 INFO - 2015-12-18 02:24:07,656 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;109;110;110;109;110;110 02:24:07 INFO - 2015-12-18 02:24:07,657 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;149;147;147;147;147;147;148;148 02:24:07 INFO - 2015-12-18 02:24:07,657 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;98;96;95;96;95;97;96;97 02:24:07 INFO - 2015-12-18 02:24:07,657 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;76;74;74;72;72;73;70;69 02:24:07 INFO - 2015-12-18 02:24:07,657 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;73;68;72;68;67;69;68;69 02:24:07 INFO - 2015-12-18 02:24:07,657 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;91;83;84;84;83;85;84;83;92 02:24:07 INFO - 2015-12-18 02:24:07,657 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;123;132;128;122;125;121;121;121;131 02:24:07 INFO - 2015-12-18 02:24:07,657 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;145;149;147;153;137;152;147;161;159 02:24:07 INFO - 2015-12-18 02:24:07,658 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;69;72;70;69;70;69;76;70 02:24:07 INFO - 2015-12-18 02:24:07,658 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:24:07 INFO - 2015-12-18 02:24:07,658 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:24:07 INFO - 2015-12-18 02:24:07,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,791 02:24:07 INFO - 2015-12-18 02:24:07,658 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:24:07 INFO - 2015-12-18 02:24:07,658 DEBUG : BROWSER_OUTPUT: __startTimestamp1450434247653__endTimestamp 02:24:07 INFO - 2015-12-18 02:24:07,658 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,666 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:24:07 INFO - 2015-12-18 02:24:07,666 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:24:07 INFO - 2015-12-18 02:24:07,666 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,666 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:4.31 (3.8%) stddev-sans-first:4.55 02:24:07 INFO - 2015-12-18 02:24:07,666 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 112.0 114.0 114.0 125.0 112.0 115.0 114.0 114.0 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.00 stddev:14.18 (9.3%) stddev-sans-first:14.90 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: Values: 153.0 131.0 155.0 169.0 131.0 149.0 151.0 133.0 167.0 137.0 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.47 (2.1%) stddev-sans-first:3.62 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 161.0 162.0 164.0 164.0 168.0 173.0 165.0 163.0 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:19.06 (25.4%) stddev-sans-first:20.08 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 72.0 80.0 73.0 135.0 75.0 77.0 75.0 79.0 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:95.00 stddev:19.98 (21.0%) stddev-sans-first:20.77 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 137.0 95.0 96.0 94.0 137.0 94.0 95.0 135.0 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 02:24:07 INFO - 2015-12-18 02:24:07,667 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 02:24:07 INFO - 2015-12-18 02:24:07,668 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,668 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:24:07 INFO - 2015-12-18 02:24:07,668 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 149.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 02:24:07 INFO - 2015-12-18 02:24:07,668 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,668 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 02:24:07 INFO - 2015-12-18 02:24:07,668 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 98.0 96.0 95.0 96.0 95.0 97.0 96.0 97.0 02:24:07 INFO - 2015-12-18 02:24:07,668 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,668 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:73.00 stddev:2.01 (2.8%) stddev-sans-first:2.13 02:24:07 INFO - 2015-12-18 02:24:07,668 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 76.0 74.0 74.0 72.0 72.0 73.0 70.0 69.0 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.50 stddev:2.02 (3.0%) stddev-sans-first:2.03 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 73.0 68.0 72.0 68.0 67.0 69.0 68.0 69.0 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:3.59 (4.3%) stddev-sans-first:3.50 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: Values: 81.0 91.0 83.0 84.0 84.0 83.0 85.0 84.0 83.0 92.0 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:126.00 stddev:4.20 (3.3%) stddev-sans-first:4.40 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: Values: 127.0 123.0 132.0 128.0 122.0 125.0 121.0 121.0 121.0 131.0 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:150.50 stddev:7.01 (4.7%) stddev-sans-first:7.31 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 149.0 147.0 153.0 137.0 152.0 147.0 161.0 159.0 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: 02:24:07 INFO - 2015-12-18 02:24:07,669 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:2.12 (3.0%) stddev-sans-first:2.24 02:24:07 INFO - 2015-12-18 02:24:07,670 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 72.0 70.0 69.0 70.0 69.0 76.0 70.0 02:24:07 INFO - 2015-12-18 02:24:07,670 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:24:07 INFO - 2015-12-18 02:24:07,670 DEBUG : BROWSER_OUTPUT: 02:24:08 INFO - 2015-12-18 02:24:08,573 INFO : Browser exited with error code: 0 02:24:08 INFO - 2015-12-18 02:24:08,629 INFO : Completed test kraken (00:01:02) 02:24:08 INFO - 2015-12-18 02:24:08,629 INFO : Starting test v8_7 02:24:08 INFO - 2015-12-18 02:24:08,629 DEBUG : operating with platform_type : linux_ 02:24:08 INFO - 2015-12-18 02:24:08,629 INFO : Initialising browser for v8_7 test... 02:24:08 INFO - 2015-12-18 02:24:08,635 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppLdm2z/profile http://localhost:34504/getInfo.html 02:24:13 INFO - 2015-12-18 02:24:13,927 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:24:13 INFO - 2015-12-18 02:24:13,927 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:24:13 INFO - 2015-12-18 02:24:13,928 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:24:13 INFO - 2015-12-18 02:24:13,928 DEBUG : BROWSER_OUTPUT: __metrics 02:24:14 INFO - 2015-12-18 02:24:14,069 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:24:15 INFO - 2015-12-18 02:24:15,037 INFO : Browser initialized. 02:24:15 INFO - 2015-12-18 02:24:15,037 INFO : Running cycle 1/1 for v8_7 test... 02:24:15 INFO - 2015-12-18 02:24:15,037 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppLdm2z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:24:27 INFO - 2015-12-18 02:24:27,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 150650880 02:24:27 INFO - 2015-12-18 02:24:27,059 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34504/tests/v8_7/run.html (next: http://localhost:34504/tests/v8_7/run.html) 02:24:48 INFO - 2015-12-18 02:24:48,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 145395712 02:24:48 INFO - 2015-12-18 02:24:48,755 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,756 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:24:48 INFO - 2015-12-18 02:24:48,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:24:48 INFO - 2015-12-18 02:24:48,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:24:48 INFO - 2015-12-18 02:24:48,757 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:24:48 INFO - 2015-12-18 02:24:48,757 DEBUG : BROWSER_OUTPUT: |0;Richards;165.92002654720426 02:24:48 INFO - 2015-12-18 02:24:48,757 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.15040953090096 02:24:48 INFO - 2015-12-18 02:24:48,757 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 02:24:48 INFO - 2015-12-18 02:24:48,757 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 02:24:48 INFO - 2015-12-18 02:24:48,757 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1076.4262648008612 02:24:48 INFO - 2015-12-18 02:24:48,757 DEBUG : BROWSER_OUTPUT: |5;Earley;758.1501137225171 02:24:48 INFO - 2015-12-18 02:24:48,758 DEBUG : BROWSER_OUTPUT: |6;Boyer;12304.878048780487 02:24:48 INFO - 2015-12-18 02:24:48,758 DEBUG : BROWSER_OUTPUT: |7;RegExp;26947.36842105263 02:24:48 INFO - 2015-12-18 02:24:48,758 DEBUG : BROWSER_OUTPUT: |8;Splay;603.1363088057901 02:24:48 INFO - 2015-12-18 02:24:48,758 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 02:24:48 INFO - 2015-12-18 02:24:48,758 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:24:48 INFO - 2015-12-18 02:24:48,759 DEBUG : BROWSER_OUTPUT: __startTimestamp1450434288755__endTimestamp 02:24:48 INFO - 2015-12-18 02:24:48,759 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,759 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:24:48 INFO - 2015-12-18 02:24:48,759 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:24:48 INFO - 2015-12-18 02:24:48,759 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,760 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.92 Median:165.92 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,760 DEBUG : BROWSER_OUTPUT: Values: 165.9 02:24:48 INFO - 2015-12-18 02:24:48,760 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,760 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.15 Median:186.15 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,760 DEBUG : BROWSER_OUTPUT: Values: 186.2 02:24:48 INFO - 2015-12-18 02:24:48,761 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,761 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,761 DEBUG : BROWSER_OUTPUT: Values: 278.0 02:24:48 INFO - 2015-12-18 02:24:48,761 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,761 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,762 DEBUG : BROWSER_OUTPUT: Values: 5229.2 02:24:48 INFO - 2015-12-18 02:24:48,762 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,762 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1076.43 Median:1076.43 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,762 DEBUG : BROWSER_OUTPUT: Values: 1076.4 02:24:48 INFO - 2015-12-18 02:24:48,762 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,763 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:758.15 Median:758.15 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,764 DEBUG : BROWSER_OUTPUT: Values: 758.2 02:24:48 INFO - 2015-12-18 02:24:48,764 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,764 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,764 DEBUG : BROWSER_OUTPUT: Values: 12304.9 02:24:48 INFO - 2015-12-18 02:24:48,764 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,764 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26947.37 Median:26947.37 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,764 DEBUG : BROWSER_OUTPUT: Values: 26947.4 02:24:48 INFO - 2015-12-18 02:24:48,764 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,764 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.14 Median:603.14 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,765 DEBUG : BROWSER_OUTPUT: Values: 603.1 02:24:48 INFO - 2015-12-18 02:24:48,765 DEBUG : BROWSER_OUTPUT: 02:24:48 INFO - 2015-12-18 02:24:48,765 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 02:24:48 INFO - 2015-12-18 02:24:48,765 DEBUG : BROWSER_OUTPUT: Values: 4826.9 02:24:48 INFO - 2015-12-18 02:24:48,765 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:24:48 INFO - 2015-12-18 02:24:48,765 DEBUG : BROWSER_OUTPUT: 02:24:49 INFO - 2015-12-18 02:24:49,745 INFO : Browser exited with error code: 0 02:24:49 INFO - 2015-12-18 02:24:49,762 INFO : Completed test v8_7 (00:00:41) 02:24:50 INFO - 2015-12-18 02:24:50,249 INFO : Completed test suite (00:20:19) 02:24:50 INFO - 2015-12-18 02:24:50,249 DEBUG : Working with test: dromaeo_css 02:24:50 INFO - 2015-12-18 02:24:50,249 DEBUG : Generating results file: dromaeo_css 02:24:50 INFO - 2015-12-18 02:24:50,250 DEBUG : Working with test: kraken 02:24:50 INFO - 2015-12-18 02:24:50,250 DEBUG : Generating results file: kraken 02:24:50 INFO - 2015-12-18 02:24:50,250 INFO : javascript benchmark 02:24:50 INFO - 2015-12-18 02:24:50,251 DEBUG : Working with test: v8_7 02:24:50 INFO - 2015-12-18 02:24:50,251 DEBUG : Generating results file: v8_7 02:24:50 INFO - 2015-12-18 02:24:50,251 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:24:50 INFO - 2015-12-18 02:24:50,292 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 02:24:50 INFO - 2015-12-18 02:24:50,293 DEBUG : process_Request line: dromaeo_css 6171.51 graph.html#tests=[[72,132,43]] 02:24:50 INFO - 2015-12-18 02:24:50,293 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:24:50 INFO - 2015-12-18 02:24:50,317 DEBUG : process_Request line: kraken 1540.20 graph.html#tests=[[232,132,43]] 02:24:50 INFO - 2015-12-18 02:24:50,317 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:24:50 INFO - 2015-12-18 02:24:50,355 DEBUG : process_Request line: v8_7 21118.44 graph.html#tests=[[230,132,43]] 02:24:50 INFO - 2015-12-18 02:24:50,356 INFO : javascript benchmark 02:24:50 INFO - 2015-12-18 02:24:50,360 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2686.6373039639648, 2702.6216329713857, 2712.0914493644627, 2750.5186592346336, 2766.5850122481634, 4585.862424127273, 4716.221823399139, 4742.217534106872, 4742.312364707115, 4745.145873742725, 4646.744429056401, 4738.052389522092, 4747.359106520618, 4753.928691069628, 4767.213409787381, 4185.602367775056, 4446.155230506193, 4455.264881294583, 4467.508574056851, 4533.546645335473, 4250.2562051641, 4475.709078909877, 4540.250858608326, 4551.089782043588, 4551.135284295973, 4306.720063195898, 4320.049589090395, 4387.890302742457, 4425.557444255581, 4444.333349997494, 4425.513193548707, 4425.557444255549, 4435.090806384684, 4481.798319075617, 4493.168763778712, 4154.937675934863, 4326.805293761789, 4422.15978963999, 4423.469183697945, 4457.799399027019, 4616.169089563878, 4655.86032419028, 4758.3100450434495, 4786.832460863853, 4793.568578827887, 5133.589312854962, 5145.073886700392, 5148.845534633967, 5154.871128221787, 5165.251038599419, 4945.258211268302, 5066.620003499752, 5180.456052114511, 5193.8961220775755, 5200.557952574036, 4755.262934245197, 4801.903961920742, 4812.759362031885, 4834.734089625104, 4890.217565189552, 5296.602754793406, 5298.0463516566615, 5306.92039619406, 5309.920351194735, 5329.600279979017, 4813.181759100961, 4926.113299606105, 4965.925511117336, 5086.92369614456, 5090.03289375025, 5164.690118592896, 5171.5862730981435, 5188.273641690166, 5192.636515443883, 5195.090859099642, 5067.8986420271385, 5072.873178170576, 5117.769700363493, 5124.128898087334, 5157.690538567698, 4806.134895718735, 4911.214205727138, 4939.678920870132, 5053.797848086036, 5083.491650834887, 4259.2759230930815, 4262.957370426318, 4278.743275403485, 4281.828726850953, 4311.719738217006, 3756.8121593920196, 3756.849726010929, 3784.3566593679143, 3785.299719551892, 3801.163743976321, 4181.644560212416, 4291.0559676871035, 4326.58897404746, 4409.647228221735, 4417.889552761207, 5122.641415100908, 5142.382914050338, 5146.742662866916, 5163.457836927144, 5193.221016847503, 4403.669724770655, 4409.316555933835, 4413.7351758894565, 4417.867463976086, 4450.020995381011, 4358.8038538265855, 4444.6666500012625, 4458.108378324348, 4531.614812740888, 4560.201964656172, 4861.683990540603, 4887.60899128076, 4898.681585696918, 4903.068417000758, 4961.255811628284, 4854.393200849894, 5180.585553155664, 5198.714070726146, 5215.608829337739, 5249.002689488985, 4769.523047695203, 4802.0, 4840.6127509798425, 4856.247281671346, 4893.73084480357, 5093.414257360451, 5128.974355128201, 5133.332666753298, 5152.3044389007, 5182.714950677598, 4911.557959783637, 5055.140626093499, 5182.585393168612, 5189.091908916, 5232.764525596282, 4900.94629654626, 4957.454679985271, 4987.650864439454, 4996.900061998667, 5019.472955339636, 4990.476000019946, 5009.248612707977, 5028.874278143076, 5037.345145131109, 5077.416097148875, 4662.650301227353, 4746.928796067993, 4754.667173297836, 4901.9264711028645, 4990.525900039491, 5003.4246061701915, 5012.022655582126, 5033.0, 5038.319826823478, 5068.417132029864, 4874.78063487151, 4907.631927605516, 4923.286123512143, 4924.015196960694, 4965.47862474435], "unit": "score", "name": "dojo.html", "value": 4692.63625663476}, {"lowerIsBetter": false, "replicates": [517.6040329148202, 536.340301429242, 542.192133720756, 545.9290292262007, 552.4365147549502, 25167.874160629195, 32477.188070298253, 32606.510902336486, 32846.83576582114, 32879.1780205495, 39439.80280098603, 39567.010824729325, 39568.0, 39672.60327396725, 39807.80096099523, 7817.648205830751, 7966.561839098877, 8031.196880311952, 8036.07585127712, 8055.436119471639, 7880.0, 7967.482113662593, 7990.680372785082, 7994.880076798852, 8020.238077382639, 7964.761057168265, 8058.35533157346, 8079.111297757242, 8092.757217283491, 8104.230098140667, 7931.24653157952, 7972.1629228931, 8011.439199256054, 8024.43828931975, 8037.03555573335, 7726.497777644435, 7819.569923654197, 7820.257075577811, 7876.094249161305, 7910.80222994424, 36749.44875826865, 37024.0, 37061.44407833885, 37216.627833721584, 37280.0, 2861.699521550228, 2913.5047042002698, 2954.069468117558, 3158.7946783459233, 3380.2056516718553, 27553.724462755315, 27909.441811163866, 28347.0, 28460.719267633005, 29200.70799292001, 3380.2732562201045, 3414.8463319150696, 3418.453047512386, 3468.2369878626914, 3540.0972751948348, 210011.0, 211527.0, 211959.0, 212019.0, 212699.0, 47524.0, 47963.280550791766, 54767.178492322644, 55085.0, 56939.430605694244, 49602.75198624056, 49775.502244977084, 49781.0, 49972.75013624909, 50068.49931500711, 13201.339933003503, 13288.402021908843, 13341.466341346237, 13347.46610135603, 13438.260895650637, 9343.018983006823, 9344.392614480174, 9367.953160234156, 9404.435733855991, 9444.8583271251, 18828.341008064654, 19464.416067517996, 19559.217631294872, 19567.119479623452, 19593.0, 7213.944025952578, 7478.775636730907, 7492.325690687864, 7516.436267279976, 7605.125410577854, 894.6376717429451, 896.1755185229605, 918.995405022984, 984.4880662055691, 1041.3959903256093, 26569.07008254702, 26584.06955756539, 26646.0, 26738.19785406441, 28785.56821647677, 929.5816882402811, 933.1601558597181, 974.0697633759743, 1075.1291453922347, 1076.6985244131656, 13207.60377188686, 13336.733265334833, 13381.19712817234, 13412.798808017887, 13517.52688655912, 263784.0, 266861.0, 267785.0, 268344.0, 269202.0, 45785.7710711451, 46191.30713039307, 46280.30579541309, 46433.30350044752, 46478.30282545764, 1242.3974372429363, 1245.2590708528412, 1262.8737126287115, 1263.6019653809021, 1266.7656483550572, 24734.505309893342, 24827.62758558587, 25293.873530632965, 25483.745162548137, 25506.48987020212, 40948.38577421401, 41029.1794164121, 41468.0, 41518.377224342265, 41536.584634153274, 255802.0, 256262.0, 256470.0, 259754.0, 260565.0, 27848.16455506338, 28981.406022668954, 29194.76675882028, 29266.122016339545, 29540.556891646214, 33294.16764580905, 33694.49458258079, 33719.49420758642, 33837.0, 33868.53012913563, 27554.724452755217, 31219.0, 32530.0, 32580.837095814368, 32957.17607059843, 29565.704342956295, 30099.849500752356, 32435.18912027124, 32659.0, 32763.180920477178, 31931.36137277288, 32228.35543289168, 32334.35331293408, 32560.67439325671, 32611.858584949412, 28063.859680701466, 29441.55837662394, 29635.407291854473, 30050.849745751133, 30187.396252075276, 22743.431414214778, 23101.88449057744, 23381.41546461352, 23445.413864652837, 23469.295921122393], "unit": "score", "name": "ext.html", "value": 16529.462122535966}, {"lowerIsBetter": false, "replicates": [323.9206394433364, 324.595878131726, 326.00964198213853, 327.21958129860275, 331.5739275031585, 14980.176090315028, 15419.69160616787, 16072.919635401806, 16149.031058136505, 16648.916755416205, 15094.320755566, 15100.942933994598, 15141.167235802026, 15164.469243576477, 15275.236238188074, 4769.809207631691, 5185.507376799198, 5191.896162076775, 5194.091034069042, 5199.272101905736, 5111.565516931047, 5140.8971820563565, 5152.046871328797, 5170.043541944752, 5172.896542069157, 4534.070515544306, 4800.615950723934, 4895.9755201224125, 5012.198048312271, 5036.672616279949, 5058.721770302632, 5073.0361231366105, 5087.9569688214015, 5090.312807770978, 5092.439831618519, 5166.302549155854, 5194.844154675328, 5197.272381866542, 5200.97399513, 5206.349206349207, 18060.548486287815, 18245.63508729818, 18385.080745962783, 18838.71741923872, 18890.62218755617, 1875.784284807251, 1882.9623407531772, 1886.9056547172586, 1886.9716954245698, 1965.4693232827058, 8347.207015333533, 8794.296456283546, 8924.0, 10158.550171082989, 12087.456064477119, 1726.4302780082542, 1729.7751292332043, 1738.4593312324048, 1744.485376813843, 1747.5718448979953, 48138.75930620325, 49237.50762492401, 49269.26096108561, 49662.50337496651, 50260.74869625665, 9552.474613896164, 9818.852717209247, 9865.358751681119, 9867.210623150131, 9910.653127140515, 12235.449404776806, 12371.443285052193, 12400.0, 12418.068644851672, 12443.315617641116, 7187.029750983655, 7195.496315257987, 7225.313595208447, 7283.417326613858, 7322.1579518355, 7078.646067696594, 7129.073220481304, 7130.322619351154, 7145.606991615407, 7145.821354466076, 4098.057446787256, 4111.732737372121, 4121.072758629344, 4123.546409894909, 4199.160167966419, 1695.482877722282, 1707.5304291319737, 1718.312674930038, 1728.5073753980055, 1750.64111857069, 388.47749776550495, 760.6691089376139, 882.6160620130264, 918.6417297253943, 1001.1690297053574, 9252.768680783034, 9747.707568772948, 9821.459819709984, 10007.249456290807, 10088.646897358703, 401.22657852292934, 407.6473850119684, 408.9488813898263, 415.08266730525276, 439.16777706246484, 5332.093544097513, 5450.454954504517, 5460.399356070829, 5515.200295957064, 5540.9168862467095, 449685.0, 452284.0, 465123.0, 469158.0, 473718.0, 77330.0, 77782.0, 78035.60982195166, 78437.60781196172, 80488.59755701185, 444.6109654052704, 446.72749622730106, 449.4000509320029, 449.8290649553149, 451.0775464175834, 9219.308551858772, 9222.985471598253, 9249.630014799603, 9268.119528644767, 9348.065193480597, 29773.404531909673, 30744.84627576848, 31261.37477250397, 31557.8422107888, 31916.5212521817, 44704.77647611741, 45842.312365315214, 47227.0, 47648.761756190994, 49133.0, 8816.647334106563, 8817.647294108165, 8916.73249802507, 8961.059088795582, 8978.730638080868, 16296.348146074024, 16461.34154633801, 16864.747028794824, 16878.915605421895, 16906.492805215865, 13056.412461439448, 13508.18950862912, 13929.164250145024, 13992.16047037181, 14418.639534011734, 13293.335333233494, 13514.324283785574, 13562.525311614441, 13959.022868399115, 14039.649008774453, 10729.570817167227, 14236.946388109942, 14391.712165756417, 14527.92736036313, 14551.636209094857, 8926.642934282556, 8980.506072166094, 9020.278377729635, 9167.954160229156, 9182.17360437564, 13683.726325473634, 13810.37853296584, 14104.506342277971, 14286.285685715466, 14365.209913454442], "unit": "score", "name": "jquery.html", "value": 7648.672152214528}, {"lowerIsBetter": false, "replicates": [1452.3464441001552, 1636.2882146266375, 1675.3131216201352, 1688.3499852556763, 1703.6933351996636, 6868.62222577758, 6923.826904327394, 7095.964520177392, 7156.105486814148, 7196.532225405345, 7164.391026762732, 7210.242924492932, 7242.31198036187, 7272.4909256352075, 7285.817854553638, 2039.8062184092526, 2070.6479898417306, 2082.3856962196114, 2083.499960009602, 2089.268755935426, 2038.1337931379178, 2075.1595603780493, 2075.543380456297, 2095.717078194447, 2097.800708932649, 1697.8811483196182, 1708.419137493252, 1898.117375420436, 2012.044278967486, 2048.8770673759623, 1969.7537807774029, 1972.9112189951416, 1974.9802501974941, 1975.9604807903904, 1981.6829307310904, 1988.4531753767685, 1992.5815578728484, 2048.7439070116234, 2057.2593866208153, 2061.0828181459256, 7069.222385537587, 7079.362857342812, 7087.681054352566, 7122.821929451753, 7153.105861767279, 3951.38753493209, 4086.5300490443383, 4094.2016306820183, 4115.629593336614, 4122.2579935611575, 2602.141293373182, 2624.5013447445117, 2647.5896236083436, 2694.0840114361213, 2694.0974773450916, 888.8133491966695, 892.1212605583495, 896.9058248883904, 897.6364572348209, 918.7932715139107, 9293.907060929372, 9420.19928306088, 9442.527873606292, 9461.763455913657, 9501.90498095024, 3588.8026158561006, 3649.799261040615, 3654.7076233901225, 3658.7804731716183, 3703.407454807218, 7665.61671916402, 7689.346405555479, 7694.653740581687, 7730.0, 7755.495892766952, 4026.899327516777, 4035.3139966205817, 4045.0494133878515, 4048.3117869962175, 4068.4100805383646, 3685.576158741779, 3697.2975134724315, 3697.6856967157555, 3700.0, 3704.555453345562, 3078.2150551609643, 3083.768717346208, 3083.92290192747, 3094.4584697677815, 3112.43976084307, 886.3839631456076, 900.6937641201891, 901.1799262670938, 905.9637614495479, 906.2432868554699, 899.1278459893892, 900.6532484993194, 907.3059109781022, 1053.331134729437, 1072.9463526823627, 6429.196350456193, 6450.322716114741, 6484.416402523795, 6487.0, 6489.1888513935755, 568.7980766827799, 573.9024365857814, 582.8571999860061, 586.0418216216517, 719.8230892490815, 5049.419316778544, 5101.821436249714, 5129.538341549204, 5134.7946082156295, 5139.203423469368, 7808.921910780819, 8147.348212143014, 8191.631376588068, 8218.342532597379, 8286.792830179173, 8057.234562716532, 8078.3133433658795, 8090.1909809018625, 8109.026916769907, 8160.143184965493, 6215.564910456315, 6385.904211436832, 6408.903866442007, 6414.486841052704, 6428.003659432796, 6146.815595532141, 6154.476869465966, 6167.660778657217, 6173.043178307369, 6180.103884936749, 7169.605671687898, 7253.1296244451005, 7307.634618268959, 7358.705651773869, 7404.222556631692, 7555.773326800205, 7559.28186822251, 7584.0, 7676.462647614837, 7691.384689224737, 5777.075667893117, 5777.508911742549, 5809.883802323845, 5848.561357898089, 5895.7052147391605, 6635.8009259722285, 6711.932880671131, 6738.124043874265, 6750.29121942189, 6770.763023294161, 6438.806835794933, 6563.409293163638, 6574.868502630016, 6614.768483103068, 6687.230968438692, 6292.622442653455, 6426.550141490238, 6429.292777794532, 6495.837604059747, 6565.0, 6272.8118156455375, 6499.057636642755, 6506.089147519446, 6509.609423434609, 6532.216134063943, 5935.673537955454, 5972.343042265435, 5990.041593345044, 6014.0678194879865, 6026.517878569792, 5764.452377024176, 5805.332386775575, 5825.766969321349, 5828.446297601721, 5843.065109582446], "unit": "score", "name": "mootools.html", "value": 3912.606978597154}, {"lowerIsBetter": false, "replicates": [295.6319382368951, 303.6659674358206, 304.1301876632829, 311.8088900400471, 312.36589722862595, 5444.346678398593, 5508.173773933912, 5561.304836895388, 5578.888422231558, 5688.459596338352, 5495.395506494282, 5497.615166938306, 5524.226608274845, 5547.306586676666, 5565.053940830058, 4270.188664153817, 4270.423492828475, 4283.614474697277, 4286.357046443043, 4292.270314046604, 4285.400043993844, 4289.077848262623, 4291.270484017725, 4292.806823692941, 4305.160493703729, 4091.713580049398, 4217.051163488206, 4225.0, 4251.06476575153, 4257.04216551275, 4169.97915010426, 4208.852690155861, 4212.452381190456, 4214.304639734441, 4225.281702110648, 3658.743887927846, 3663.6519530644546, 3663.7984910829896, 3668.046307959923, 3670.614585468514, 5306.097963346202, 5307.442718514578, 5314.176302673091, 5314.362276526803, 5329.920051199235, 4777.474477807438, 4781.737004464753, 4807.495213002654, 4813.326134341195, 4821.915069109457, 5765.88468230633, 5799.101139323411, 5810.709464526757, 5813.273340832396, 5814.273215848019, 4084.5098588169312, 4086.5300490443383, 4086.59134086589, 4091.590840915914, 4097.795110244476, 6051.425114614105, 6121.571489995702, 6127.816165515042, 6139.355367686373, 6142.0, 4034.677225821927, 4156.854510092132, 4173.4157217989505, 4175.434212170436, 4197.601227883346, 4220.451341325608, 4225.133847561243, 4227.682923780729, 4229.407882896397, 4235.195312890541, 4863.0, 4863.443698016601, 4871.707697538159, 4876.097921884463, 4877.6829506081995, 5802.912956305659, 5827.446392592697, 5833.183354330397, 5843.1235314703135, 5843.386444423274, 1487.9851201488063, 1493.6415260337442, 1496.8203815542204, 1497.176552895903, 1528.3198976455592, 1028.0850043461326, 1051.64244156987, 1058.2856571813995, 1061.766411389493, 1069.7058308965097, 4987.376577927759, 4999.800007999712, 5019.0965626187635, 5020.799168033311, 5023.070731914608, 5891.0, 5915.526757859361, 5935.0, 5944.048952167633, 5958.165856780054, 4944.184209605375, 4974.825881094217, 4977.726225057584, 4995.925061124086, 5020.7740651670765, 3160.652328243891, 3199.472087105648, 3207.0699497146034, 3214.067920303086, 3227.064151396116, 5579.609427340129, 5584.218209450599, 5599.44005599445, 5600.775968961196, 5619.353774315924, 6068.4841788448475, 6092.147099406086, 6104.0, 6118.847028824315, 6139.2325959255095, 5468.644538105011, 5589.496945274864, 5589.972050139723, 5602.187682786055, 5602.887942241214, 5929.52563794904, 5949.0, 5951.047832346804, 5959.046552551571, 5971.671558064349, 5798.913016304675, 5805.129230615442, 5809.854753631024, 5810.709464526842, 5831.620944638585, 5602.579806514446, 5605.1872478491205, 5611.158326251095, 5612.803551875665, 5631.986242476393, 4131.586841315844, 4194.727342722713, 4216.24107660624, 4267.317229243306, 4269.359596060615, 5942.465178133989, 5951.494122999594, 5957.6127551709, 5962.2249107615735, 5962.940370596412, 5802.65184088956, 5806.82579522615, 5876.059830427112, 5877.588568800143, 5880.8235752927485, 5833.154192642128, 5860.326062502696, 5861.648301101947, 5865.208196893364, 5870.090136028923, 5620.353659329229, 5737.225474560881, 5737.885242295214, 5751.367349591458, 5751.597388182787, 5885.176075349369, 5886.911696324473, 5892.027815410581, 5894.6757928314355, 5900.940990590039, 5675.290588676416, 5695.345035320991, 5711.543076553782, 5751.0, 5758.798442054508], "unit": "score", "name": "prototype.html", "value": 4347.684329596593}, {"lowerIsBetter": false, "replicates": [576.7318197038377, 603.2851071480296, 676.3000294694986, 697.2574208467983, 699.4369532526316, 10429.478526073704, 10618.946905265473, 10631.202659800518, 10637.095846853008, 10711.625093121742, 10728.946355268212, 12498.062645301594, 12681.54162271339, 12731.299778512179, 12745.235285882853, 770.9383249340053, 778.7040924448702, 785.1677222144516, 785.4541093939714, 792.4175730837829, 797.0674311056049, 800.4716886854677, 801.1027649033063, 802.8233788566536, 806.8265322955564, 826.7643721539363, 835.2524490580927, 837.0624900111883, 837.2966707965307, 837.4891316297054, 818.2145140664969, 820.885076089348, 822.6051495282268, 823.8928939237891, 824.2622852546997, 616.3282022595348, 616.374380004296, 616.7193926763312, 619.1393962392278, 621.2420846567181, 11728.765424691544, 11764.588239411665, 11824.704382390422, 11844.052475801915, 11848.28910265387, 10527.21045921559, 10745.08666763326, 10863.619773307897, 10887.891121088767, 11244.325340479598, 8878.378513504058, 9106.86339704905, 9345.0, 9378.624855005792, 9532.761680958032, 3145.1665308693214, 3151.07043422191, 3201.0, 3228.2413632796274, 3288.523164141186, 38274.80862595669, 38292.80853595742, 38305.23389532194, 38406.80796596027, 38533.22933541313, 8815.162559556831, 8892.555372231363, 9110.088991100969, 9128.817423651622, 9146.588403521857, 15396.615084622974, 15460.845391546165, 15586.844131558766, 15606.453774117852, 15629.921850390676, 6193.628382297076, 6228.750849965951, 6338.112664227012, 6378.107065010902, 6439.0, 3398.8300584970652, 3486.825658717054, 3543.3976224041457, 3555.3422616815456, 3565.4830049642655, 2499.3251822007956, 2508.8243822932586, 2525.6590360301125, 2537.403710128155, 2547.210364786922, 440.47363400735816, 441.86743976806827, 443.1978119603528, 449.16679559417463, 449.2721790699088, 399.2115571745779, 426.6821218192467, 430.15045285561393, 441.111161010564, 458.3056669146246, 6753.392194702402, 7099.609521476368, 7710.537367757953, 7773.3004029637605, 8153.306968907709, 450.1582041582197, 460.1441319146385, 492.7856382473635, 496.09957926363535, 518.440084708514, 3172.666869978665, 3295.8681652734103, 3342.19787251058, 3367.8316084195694, 3433.7939723616664, 49575.752121239166, 49933.0, 49967.750161249685, 55701.44298557044, 55811.72094139503, 43306.0, 44078.55921440809, 44236.11527769427, 44316.0, 44353.77823110864, 40468.797656011535, 40541.59458405437, 40860.0, 40941.79529102395, 40966.180676386306, 7227.205007449282, 7279.636018199175, 7663.348615367533, 7712.652930618248, 7911.485753426009, 28374.85812570924, 29018.0, 29146.854265728536, 29154.708452915198, 31613.683863161074, 39293.0, 39564.80217598894, 39596.40605390979, 39863.0, 40139.59860401358, 9451.0, 9635.951820240854, 9739.172170365599, 9789.412635241908, 9861.901380986385, 10824.296420732628, 10950.06924411434, 10994.394272798922, 11260.099192064452, 11435.313881167156, 9385.436873787594, 9565.139137477661, 9810.068043535854, 9893.703188904345, 9897.257705672248, 9640.42157470554, 9654.131128198496, 9684.32209745311, 9826.0, 10120.595176193165, 9954.601815927283, 10096.242781791541, 10264.64073757415, 10345.224108192066, 10593.629222977159, 8241.340692744687, 8383.95808020956, 8387.622556984828, 8474.855564932095, 8786.956065219632, 8347.749567512985, 8585.613647385757, 8651.52416617092, 8672.219500245008, 8829.426087304304], "unit": "score", "name": "yui.html", "value": 5474.192911146616}], "name": "dromaeo_css", "value": 6171.512257534559}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 112.0, 114.0, 114.0, 125.0, 112.0, 115.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 155.0, 169.0, 131.0, 149.0, 151.0, 133.0, 167.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 161.0, 162.0, 164.0, 164.0, 168.0, 173.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 72.0, 80.0, 73.0, 135.0, 75.0, 77.0, 75.0, 79.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 137.0, 95.0, 96.0, 94.0, 137.0, 94.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 98.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 76.0, 74.0, 74.0, 72.0, 72.0, 73.0, 70.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 73.0, 68.0, 72.0, 68.0, 67.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [81.0, 91.0, 83.0, 84.0, 84.0, 83.0, 85.0, 84.0, 83.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [127.0, 123.0, 132.0, 128.0, 122.0, 125.0, 121.0, 121.0, 121.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 149.0, 147.0, 153.0, 137.0, 152.0, 147.0, 161.0, 159.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 72.0, 70.0, 69.0, 70.0, 69.0, 76.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1540.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.92002654720426], "unit": "score", "name": "Richards", "value": 212.765154}, {"lowerIsBetter": false, "replicates": [186.15040953090096], "unit": "score", "name": "DeltaBlue", "value": 355.1858960000002}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1076.4262648008612], "unit": "score", "name": "RayTrace", "value": 687.4497810000001}, {"lowerIsBetter": false, "replicates": [758.1501137225171], "unit": "score", "name": "Earley", "value": 879.0646969999996}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [26947.36842105263], "unit": "score", "name": "RegExp", "value": 33.80608398437501}, {"lowerIsBetter": false, "replicates": [603.1363088057901], "unit": "score", "name": "Splay", "value": 135.11207800000005}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21118.44045468391}]} 02:24:50 INFO - RETURN: dromaeo_css: 6171.51 02:24:50 INFO - RETURN: kraken: 1540.20 02:24:50 INFO - RETURN: v8_7: 21118.44 02:24:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21118.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1540.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6171.51"}}} 02:24:50 INFO - Return code: 0 02:24:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:24:50 INFO - # TBPL SUCCESS # 02:24:50 INFO - Running post-action listener: _resource_record_post_action 02:24:50 INFO - Running post-run listener: _resource_record_post_run 02:24:51 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 8192; Write bytes: 542904320; Read time: 396; Write time: 751644 02:24:51 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 226766848; Read time: 0; Write time: 408920 02:24:51 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8192; Write bytes: 315273216; Read time: 396; Write time: 342680 02:24:51 INFO - Running post-run listener: _upload_blobber_files 02:24:51 INFO - Blob upload gear active. 02:24:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:24:51 INFO - Copying logs to upload dir... 02:24:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.399583 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-18 02:24:50.106127) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 02:24:50.109804) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009982 build_url: 'https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 02:24:50.160103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:24:50.160395) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450414911.6036-266482039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:24:50.209865) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 02:24:50.210177) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 02:24:50.210443) ========= ========= Total master_lag: 0.21 =========