builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1450302185.01 results: success (0) buildid: 20151216130002 builduid: 01352fc03f274a64ba122c3cee850a73 revision: 1e8421b447c4e1034f54d6a520525fefd8412f45 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.006959) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.007338) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.007627) ========= 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=b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006384 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.032348) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.032651) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.074197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.074458) ========= 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=b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.126278) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.126552) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.126875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.127142) ========= 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=b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 13:43:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-16 13:43:05 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186550 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.335852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.336123) ========= 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=b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014501 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.421982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:05.422295) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1e8421b447c4e1034f54d6a520525fefd8412f45 --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 1e8421b447c4e1034f54d6a520525fefd8412f45 --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=b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 13:43:05,635 truncating revision to first 12 chars 2015-12-16 13:43:05,635 Setting DEBUG logging. 2015-12-16 13:43:05,635 attempt 1/10 2015-12-16 13:43:05,635 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1e8421b447c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 13:43:06,281 unpacking tar archive at: fx-team-1e8421b447c4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:06.350672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:06.350962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:06.359121) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:06.359370) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 13:43:06.359780) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-16 13:43:06.360059) ========= /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=b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:43:06 INFO - MultiFileLogger online at 20151216 13:43:06 in /builds/slave/test 13:43:06 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 13:43:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:43:06 INFO - {'append_to_log': False, 13:43:06 INFO - 'base_work_dir': '/builds/slave/test', 13:43:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:43:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:43:06 INFO - 'branch': 'Fx-Team-Non-PGO', 13:43:06 INFO - 'buildbot_json_path': 'buildprops.json', 13:43:06 INFO - 'config_files': ('talos/linux_config.py',), 13:43:06 INFO - 'default_actions': ('clobber', 13:43:06 INFO - 'read-buildbot-config', 13:43:06 INFO - 'download-and-extract', 13:43:06 INFO - 'populate-webroot', 13:43:06 INFO - 'create-virtualenv', 13:43:06 INFO - 'install', 13:43:06 INFO - 'run-tests'), 13:43:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:43:06 INFO - 'download_minidump_stackwalk': True, 13:43:06 INFO - 'download_symbols': 'ondemand', 13:43:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:43:06 INFO - 'tooltool.py': '/tools/tooltool.py', 13:43:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:43:06 INFO - '/tools/misc-python/virtualenv.py')}, 13:43:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:43:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:43:06 INFO - 'installer_path': 'installer.exe', 13:43:06 INFO - 'log_level': 'info', 13:43:06 INFO - 'log_name': 'talos', 13:43:06 INFO - 'log_to_console': True, 13:43:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:43:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:43:06 INFO - 'opt_config_files': (), 13:43:06 INFO - 'pip_index': False, 13:43:06 INFO - 'sps_profile': False, 13:43:06 INFO - 'sps_profile_interval': 0, 13:43:06 INFO - 'suite': 'dromaeojs-e10s', 13:43:06 INFO - 'system_bits': '64', 13:43:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:43:06 INFO - 'title': 'talos-linux64-ix-028', 13:43:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:43:06 INFO - 'use_talos_json': True, 13:43:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:43:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:43:06 INFO - 'work_dir': 'build'} 13:43:06 INFO - ##### 13:43:06 INFO - ##### Running clobber step. 13:43:06 INFO - ##### 13:43:06 INFO - Running pre-action listener: _resource_record_pre_action 13:43:06 INFO - Running main action method: clobber 13:43:06 INFO - rmtree: /builds/slave/test/build 13:43:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:43:07 INFO - Running post-action listener: _resource_record_post_action 13:43:07 INFO - ##### 13:43:07 INFO - ##### Running read-buildbot-config step. 13:43:07 INFO - ##### 13:43:07 INFO - Running pre-action listener: _resource_record_pre_action 13:43:07 INFO - Running main action method: read_buildbot_config 13:43:07 INFO - Using buildbot properties: 13:43:07 INFO - { 13:43:07 INFO - "project": "", 13:43:07 INFO - "product": "firefox", 13:43:07 INFO - "script_repo_revision": "production", 13:43:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:43:07 INFO - "repository": "", 13:43:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:43:07 INFO - "buildid": "20151216130002", 13:43:07 INFO - "pgo_build": "False", 13:43:07 INFO - "basedir": "/builds/slave/test", 13:43:07 INFO - "buildnumber": 577, 13:43:07 INFO - "slavename": "talos-linux64-ix-028", 13:43:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:43:07 INFO - "platform": "ubuntu64_hw", 13:43:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:43:07 INFO - "branch": "fx-team", 13:43:07 INFO - "repo_path": "integration/fx-team", 13:43:07 INFO - "revision": "1e8421b447c4e1034f54d6a520525fefd8412f45", 13:43:07 INFO - "stage_platform": "linux64", 13:43:07 INFO - "builduid": "01352fc03f274a64ba122c3cee850a73", 13:43:07 INFO - "slavebuilddir": "test" 13:43:07 INFO - } 13:43:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:43:07 INFO - Running post-action listener: _resource_record_post_action 13:43:07 INFO - ##### 13:43:07 INFO - ##### Running download-and-extract step. 13:43:07 INFO - ##### 13:43:07 INFO - Running pre-action listener: _resource_record_pre_action 13:43:07 INFO - Running main action method: download_and_extract 13:43:07 INFO - mkdir: /builds/slave/test/build/tests 13:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:07 INFO - https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:43:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/test_packages.json 13:43:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/test_packages.json 13:43:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:43:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:43:11 INFO - Downloaded 1302 bytes. 13:43:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:43:11 INFO - Using the following test package requirements: 13:43:11 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:11 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:43:11 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:11 INFO - u'jsshell-linux-x86_64.zip'], 13:43:11 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:43:11 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:11 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:43:11 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:43:11 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:43:11 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:11 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:43:11 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:43:11 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')]} 13:43:11 INFO - https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/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 13:43:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/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 13:43:13 INFO - Downloaded 21870297 bytes. 13:43:13 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 13:43:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:13 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 13:43:14 INFO - Return code: 0 13:43:14 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 13:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:14 INFO - https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/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 13:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/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 13:43:15 INFO - Downloaded 21870297 bytes. 13:43:15 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 13:43:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:15 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 13:43:16 INFO - Return code: 0 13:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:16 INFO - https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:43:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/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 13:43:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/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 13:43:18 INFO - Downloaded 11132052 bytes. 13:43:18 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 13:43:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:18 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 13:43:18 INFO - Return code: 0 13:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:18 INFO - https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:43:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:43:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:43:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/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 13:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kub_x9m4RjqATGnTQmu8Qg/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 13:43:20 INFO - Downloaded 57774714 bytes. 13:43:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:43:20 INFO - mkdir: /builds/slave/test/properties 13:43:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:43:20 INFO - Writing to file /builds/slave/test/properties/build_url 13:43:20 INFO - Contents: 13:43:20 INFO - build_url:https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:43:20 INFO - Running post-action listener: _resource_record_post_action 13:43:20 INFO - Running post-action listener: set_extra_try_arguments 13:43:20 INFO - ##### 13:43:20 INFO - ##### Running populate-webroot step. 13:43:20 INFO - ##### 13:43:20 INFO - Running pre-action listener: _resource_record_pre_action 13:43:20 INFO - Running main action method: populate_webroot 13:43:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:43:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:43:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:43:20 INFO - '--tppagecycles', 13:43:20 INFO - '7'], 13:43:20 INFO - 'tests': ['tsvgm']}}, 13:43:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:43:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:43:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:43:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:43:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:43:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:43:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:20 INFO - 'talos_options': ['--e10s'], 13:43:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:20 INFO - 'tests': ['damp', 'tps']}, 13:43:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:20 INFO - 'talos_options': ['--e10s'], 13:43:20 INFO - 'tests': ['damp', 'tps']}, 13:43:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:43:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:43:20 INFO - 'other': {'tests': ['a11yr', 13:43:20 INFO - 'ts_paint', 13:43:20 INFO - 'tpaint', 13:43:20 INFO - 'sessionrestore', 13:43:20 INFO - 'sessionrestore_no_auto_restore']}, 13:43:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:43:20 INFO - 'tests': ['a11yr', 13:43:20 INFO - 'ts_paint', 13:43:20 INFO - 'tpaint', 13:43:20 INFO - 'sessionrestore', 13:43:20 INFO - 'sessionrestore_no_auto_restore']}, 13:43:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:43:20 INFO - 'tests': ['a11yr', 13:43:20 INFO - 'ts_paint', 13:43:20 INFO - 'tpaint', 13:43:20 INFO - 'sessionrestore', 13:43:20 INFO - 'sessionrestore_no_auto_restore']}, 13:43:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:43:20 INFO - 'tests': ['a11yr', 13:43:20 INFO - 'ts_paint', 13:43:20 INFO - 'tpaint', 13:43:20 INFO - 'sessionrestore', 13:43:20 INFO - 'sessionrestore_no_auto_restore']}, 13:43:20 INFO - 'other_l64': {'tests': ['a11yr', 13:43:20 INFO - 'ts_paint', 13:43:20 INFO - 'tpaint', 13:43:20 INFO - 'sessionrestore', 13:43:20 INFO - 'sessionrestore_no_auto_restore']}, 13:43:20 INFO - 'other_nol64': {'tests': ['a11yr', 13:43:20 INFO - 'ts_paint', 13:43:20 INFO - 'tpaint', 13:43:20 INFO - 'sessionrestore', 13:43:20 INFO - 'sessionrestore_no_auto_restore']}, 13:43:20 INFO - 'svgr': {'tests': ['tsvgx', 13:43:20 INFO - 'tsvgr_opacity', 13:43:20 INFO - 'tart', 13:43:20 INFO - 'tscrollx', 13:43:20 INFO - 'cart']}, 13:43:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:43:20 INFO - 'tests': ['tsvgx', 13:43:20 INFO - 'tsvgr_opacity', 13:43:20 INFO - 'tart', 13:43:20 INFO - 'tscrollx', 13:43:20 INFO - 'cart']}, 13:43:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:20 INFO - 'tests': ['tp5o']}, 13:43:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:20 INFO - 'talos_options': ['--e10s'], 13:43:20 INFO - 'tests': ['tp5o']}, 13:43:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:20 INFO - 'talos_options': ['--xperf_path', 13:43:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:20 INFO - 'tests': ['tp5n']}, 13:43:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:20 INFO - 'talos_options': ['--e10s', 13:43:20 INFO - '--xperf_path', 13:43:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:20 INFO - 'tests': ['tp5n']}}, 13:43:20 INFO - 'talos.zip': {'path': '', 13:43:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:43:20 INFO - Running post-action listener: _resource_record_post_action 13:43:20 INFO - ##### 13:43:20 INFO - ##### Running create-virtualenv step. 13:43:20 INFO - ##### 13:43:20 INFO - Running pre-action listener: _resource_record_pre_action 13:43:20 INFO - Running main action method: create_virtualenv 13:43:20 INFO - Creating virtualenv /builds/slave/test/build/venv 13:43:20 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 13:43:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:43:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:43:20 INFO - Using real prefix '/usr' 13:43:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:43:20 INFO - Installing distribute.............................................................................................................................................................................................done. 13:43:22 INFO - Installing pip.................done. 13:43:22 INFO - Return code: 0 13:43:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:22 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 0x7f6e714e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, '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': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', '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 13:43:22 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 13:43:22 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 13:43:22 INFO - Using env: {'DISPLAY': ':0', 13:43:22 INFO - 'HOME': '/home/cltbld', 13:43:22 INFO - 'LANG': 'en_US.UTF-8', 13:43:22 INFO - 'LANGUAGE': 'en_US:en', 13:43:22 INFO - 'LOGNAME': 'cltbld', 13:43:22 INFO - 'MAIL': '/var/mail/cltbld', 13:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:22 INFO - 'MOZ_NO_REMOTE': '1', 13:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:22 INFO - 'NO_EM_RESTART': '1', 13:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:22 INFO - 'PWD': '/builds/slave/test', 13:43:22 INFO - 'SHELL': '/bin/bash', 13:43:22 INFO - 'SHLVL': '1', 13:43:22 INFO - 'TERM': 'linux', 13:43:22 INFO - 'TMOUT': '86400', 13:43:22 INFO - 'USER': 'cltbld', 13:43:22 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:22 INFO - '_': '/tools/buildbot/bin/python'} 13:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:23 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 13:43:23 INFO - Cleaning up... 13:43:23 INFO - Return code: 0 13:43:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:23 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 0x7f6e714e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, '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': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', '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 13:43:23 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 13:43:23 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 13:43:23 INFO - Using env: {'DISPLAY': ':0', 13:43:23 INFO - 'HOME': '/home/cltbld', 13:43:23 INFO - 'LANG': 'en_US.UTF-8', 13:43:23 INFO - 'LANGUAGE': 'en_US:en', 13:43:23 INFO - 'LOGNAME': 'cltbld', 13:43:23 INFO - 'MAIL': '/var/mail/cltbld', 13:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:23 INFO - 'MOZ_NO_REMOTE': '1', 13:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:23 INFO - 'NO_EM_RESTART': '1', 13:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:23 INFO - 'PWD': '/builds/slave/test', 13:43:23 INFO - 'SHELL': '/bin/bash', 13:43:23 INFO - 'SHLVL': '1', 13:43:23 INFO - 'TERM': 'linux', 13:43:23 INFO - 'TMOUT': '86400', 13:43:23 INFO - 'USER': 'cltbld', 13:43:23 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:23 INFO - '_': '/tools/buildbot/bin/python'} 13:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:23 INFO - Downloading/unpacking psutil>=0.7.1 13:43:23 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 13:43:23 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 13:43:23 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 13:43:23 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 13:43:23 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 13:43:23 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 13:43:24 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:43:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:43:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:25 INFO - Installing collected packages: psutil 13:43:25 INFO - Running setup.py install for psutil 13:43:25 INFO - building 'psutil._psutil_linux' extension 13:43:25 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 13:43:25 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 13:43:25 INFO - building 'psutil._psutil_posix' extension 13:43:25 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 13:43:25 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 13:43:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:25 INFO - Successfully installed psutil 13:43:25 INFO - Cleaning up... 13:43:25 INFO - Return code: 0 13:43:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:25 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 0x7f6e714e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, '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': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', '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 13:43:25 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 13:43:25 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 13:43:25 INFO - Using env: {'DISPLAY': ':0', 13:43:25 INFO - 'HOME': '/home/cltbld', 13:43:25 INFO - 'LANG': 'en_US.UTF-8', 13:43:25 INFO - 'LANGUAGE': 'en_US:en', 13:43:25 INFO - 'LOGNAME': 'cltbld', 13:43:25 INFO - 'MAIL': '/var/mail/cltbld', 13:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:25 INFO - 'MOZ_NO_REMOTE': '1', 13:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:25 INFO - 'NO_EM_RESTART': '1', 13:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:25 INFO - 'PWD': '/builds/slave/test', 13:43:25 INFO - 'SHELL': '/bin/bash', 13:43:25 INFO - 'SHLVL': '1', 13:43:25 INFO - 'TERM': 'linux', 13:43:25 INFO - 'TMOUT': '86400', 13:43:25 INFO - 'USER': 'cltbld', 13:43:25 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:25 INFO - '_': '/tools/buildbot/bin/python'} 13:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:43:25 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 13:43:25 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 13:43:25 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 13:43:25 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 13:43:25 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 13:43:25 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 13:43:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:43:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:43:27 INFO - Installing collected packages: mozsystemmonitor 13:43:27 INFO - Running setup.py install for mozsystemmonitor 13:43:27 INFO - Successfully installed mozsystemmonitor 13:43:27 INFO - Cleaning up... 13:43:27 INFO - Return code: 0 13:43:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:43:27 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')]} 13:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:27 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')]} 13:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:27 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 0x7f6e714e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, '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': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', '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 13:43:27 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 13:43:27 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 13:43:27 INFO - Using env: {'DISPLAY': ':0', 13:43:27 INFO - 'HOME': '/home/cltbld', 13:43:27 INFO - 'LANG': 'en_US.UTF-8', 13:43:27 INFO - 'LANGUAGE': 'en_US:en', 13:43:27 INFO - 'LOGNAME': 'cltbld', 13:43:27 INFO - 'MAIL': '/var/mail/cltbld', 13:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:27 INFO - 'MOZ_NO_REMOTE': '1', 13:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:27 INFO - 'NO_EM_RESTART': '1', 13:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:27 INFO - 'PWD': '/builds/slave/test', 13:43:27 INFO - 'SHELL': '/bin/bash', 13:43:27 INFO - 'SHLVL': '1', 13:43:27 INFO - 'TERM': 'linux', 13:43:27 INFO - 'TMOUT': '86400', 13:43:27 INFO - 'USER': 'cltbld', 13:43:27 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:27 INFO - '_': '/tools/buildbot/bin/python'} 13:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:27 INFO - Downloading/unpacking blobuploader==1.2.4 13:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:29 INFO - Downloading blobuploader-1.2.4.tar.gz 13:43:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:43:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:43:29 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 13:43:29 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 13:43:29 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 13:43:29 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 13:43:29 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 13:43:29 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 13:43:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:43:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:30 INFO - Downloading docopt-0.6.1.tar.gz 13:43:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:43:30 INFO - Installing collected packages: blobuploader, requests, docopt 13:43:30 INFO - Running setup.py install for blobuploader 13:43:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:43:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:43:30 INFO - Running setup.py install for requests 13:43:30 INFO - Running setup.py install for docopt 13:43:30 INFO - Successfully installed blobuploader requests docopt 13:43:30 INFO - Cleaning up... 13:43:30 INFO - Return code: 0 13:43:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:30 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')]} 13:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:30 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')]} 13:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:30 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 0x7f6e714e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, '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': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', '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 13:43:30 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 13:43:30 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 13:43:30 INFO - Using env: {'DISPLAY': ':0', 13:43:30 INFO - 'HOME': '/home/cltbld', 13:43:30 INFO - 'LANG': 'en_US.UTF-8', 13:43:30 INFO - 'LANGUAGE': 'en_US:en', 13:43:30 INFO - 'LOGNAME': 'cltbld', 13:43:30 INFO - 'MAIL': '/var/mail/cltbld', 13:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:30 INFO - 'MOZ_NO_REMOTE': '1', 13:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:30 INFO - 'NO_EM_RESTART': '1', 13:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:30 INFO - 'PWD': '/builds/slave/test', 13:43:30 INFO - 'SHELL': '/bin/bash', 13:43:30 INFO - 'SHLVL': '1', 13:43:30 INFO - 'TERM': 'linux', 13:43:30 INFO - 'TMOUT': '86400', 13:43:30 INFO - 'USER': 'cltbld', 13:43:30 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:30 INFO - '_': '/tools/buildbot/bin/python'} 13:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:43:31 INFO - Running setup.py (path:/tmp/pip-I3N0aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:43:31 INFO - Running setup.py (path:/tmp/pip-H0r2Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:43:31 INFO - Running setup.py (path:/tmp/pip-IcuiQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:43:31 INFO - Running setup.py (path:/tmp/pip-WrN6RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:43:31 INFO - Running setup.py (path:/tmp/pip-JlwCzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:43:31 INFO - Running setup.py (path:/tmp/pip-_1p9EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:43:31 INFO - Running setup.py (path:/tmp/pip-yAyOLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:43:31 INFO - Running setup.py (path:/tmp/pip-ykfjYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:43:31 INFO - Running setup.py (path:/tmp/pip-JBgf6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:43:31 INFO - Running setup.py (path:/tmp/pip-23oK_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:43:31 INFO - Running setup.py (path:/tmp/pip-mIEP2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:43:31 INFO - Running setup.py (path:/tmp/pip-Nra6K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:43:32 INFO - Running setup.py (path:/tmp/pip-r9u8bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:43:32 INFO - Running setup.py (path:/tmp/pip-tN5li4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:32 INFO - Running setup.py (path:/tmp/pip-1DR0r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:43:32 INFO - Running setup.py (path:/tmp/pip-IGb1ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:43:32 INFO - Running setup.py (path:/tmp/pip-WCfBAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:43:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:43:32 INFO - Running setup.py install for manifestparser 13:43:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:43:32 INFO - Running setup.py install for mozcrash 13:43:32 INFO - Running setup.py install for mozdebug 13:43:32 INFO - Running setup.py install for mozdevice 13:43:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:43:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:43:32 INFO - Running setup.py install for mozfile 13:43:32 INFO - Running setup.py install for mozhttpd 13:43:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:43:32 INFO - Running setup.py install for mozinfo 13:43:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Running setup.py install for mozInstall 13:43:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Running setup.py install for mozleak 13:43:33 INFO - Running setup.py install for mozlog 13:43:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Running setup.py install for moznetwork 13:43:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Running setup.py install for mozprocess 13:43:33 INFO - Running setup.py install for mozprofile 13:43:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Running setup.py install for mozrunner 13:43:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:43:33 INFO - Running setup.py install for mozscreenshot 13:43:33 INFO - Running setup.py install for moztest 13:43:34 INFO - Running setup.py install for mozversion 13:43:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:43:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:43:34 INFO - Cleaning up... 13:43:34 INFO - Return code: 0 13:43:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:34 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 0x7f6e714e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, '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': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', '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 13:43:34 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 13:43:34 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 13:43:34 INFO - Using env: {'DISPLAY': ':0', 13:43:34 INFO - 'HOME': '/home/cltbld', 13:43:34 INFO - 'LANG': 'en_US.UTF-8', 13:43:34 INFO - 'LANGUAGE': 'en_US:en', 13:43:34 INFO - 'LOGNAME': 'cltbld', 13:43:34 INFO - 'MAIL': '/var/mail/cltbld', 13:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:34 INFO - 'MOZ_NO_REMOTE': '1', 13:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:34 INFO - 'NO_EM_RESTART': '1', 13:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:34 INFO - 'PWD': '/builds/slave/test', 13:43:34 INFO - 'SHELL': '/bin/bash', 13:43:34 INFO - 'SHLVL': '1', 13:43:34 INFO - 'TERM': 'linux', 13:43:34 INFO - 'TMOUT': '86400', 13:43:34 INFO - 'USER': 'cltbld', 13:43:34 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:34 INFO - '_': '/tools/buildbot/bin/python'} 13:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:43:34 INFO - Running setup.py (path:/tmp/pip-m7Rqhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:43:34 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)) 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:43:34 INFO - Running setup.py (path:/tmp/pip-0qQbi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:43:34 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)) 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:43:34 INFO - Running setup.py (path:/tmp/pip-ddLboV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:43:34 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)) 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:43:34 INFO - Running setup.py (path:/tmp/pip-AFn4SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:43:34 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)) 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:43:34 INFO - Running setup.py (path:/tmp/pip-JtO9GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:43:34 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)) 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:43:34 INFO - Running setup.py (path:/tmp/pip-faW8Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:43:34 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)) 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:43:34 INFO - Running setup.py (path:/tmp/pip-p8LEXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:43:34 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)) 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:43:34 INFO - Running setup.py (path:/tmp/pip-iCfAZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:43:34 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)) 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:43:34 INFO - Running setup.py (path:/tmp/pip-j84all-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:43:34 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)) 13:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:43:34 INFO - Running setup.py (path:/tmp/pip-2oWH88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:43:35 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)) 13:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:43:35 INFO - Running setup.py (path:/tmp/pip-ybNn1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:43:35 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)) 13:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:43:35 INFO - Running setup.py (path:/tmp/pip-jBiM54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:43:35 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)) 13:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:43:35 INFO - Running setup.py (path:/tmp/pip-_n7LF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:43:35 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)) 13:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:43:35 INFO - Running setup.py (path:/tmp/pip-SQ6n3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:43:35 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)) 13:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:35 INFO - Running setup.py (path:/tmp/pip-Ihd95r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:35 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)) 13:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:43:35 INFO - Running setup.py (path:/tmp/pip-OKJ4yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:43:35 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)) 13:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:43:35 INFO - Running setup.py (path:/tmp/pip-bw5tIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:43:35 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)) 13:43:35 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)) 13:43:35 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)) 13:43:35 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)) 13:43:35 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)) 13:43:35 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)) 13:43:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:37 INFO - Downloading blessings-1.5.1.tar.gz 13:43:37 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 13:43:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:43:37 INFO - Installing collected packages: blessings 13:43:37 INFO - Running setup.py install for blessings 13:43:37 INFO - Successfully installed blessings 13:43:37 INFO - Cleaning up... 13:43:37 INFO - Return code: 0 13:43:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:43:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:43:37 INFO - Reading from file tmpfile_stdout 13:43:37 INFO - Current package versions: 13:43:37 INFO - argparse == 1.2.1 13:43:37 INFO - blessings == 1.5.1 13:43:37 INFO - blobuploader == 1.2.4 13:43:37 INFO - docopt == 0.6.1 13:43:37 INFO - manifestparser == 1.1 13:43:37 INFO - mozInstall == 1.12 13:43:37 INFO - mozcrash == 0.16 13:43:37 INFO - mozdebug == 0.1 13:43:37 INFO - mozdevice == 0.47 13:43:37 INFO - mozfile == 1.2 13:43:37 INFO - mozhttpd == 0.7 13:43:37 INFO - mozinfo == 0.9 13:43:37 INFO - mozleak == 0.1 13:43:37 INFO - mozlog == 3.1 13:43:37 INFO - moznetwork == 0.27 13:43:37 INFO - mozprocess == 0.22 13:43:37 INFO - mozprofile == 0.27 13:43:37 INFO - mozrunner == 6.11 13:43:37 INFO - mozscreenshot == 0.1 13:43:37 INFO - mozsystemmonitor == 0.0 13:43:37 INFO - moztest == 0.7 13:43:37 INFO - mozversion == 1.4 13:43:37 INFO - psutil == 3.1.1 13:43:37 INFO - requests == 1.2.3 13:43:37 INFO - wsgiref == 0.1.2 13:43:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:37 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 0x7f6e714e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, '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': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', '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 13:43:37 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 13:43:37 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 13:43:37 INFO - Using env: {'DISPLAY': ':0', 13:43:37 INFO - 'HOME': '/home/cltbld', 13:43:37 INFO - 'LANG': 'en_US.UTF-8', 13:43:37 INFO - 'LANGUAGE': 'en_US:en', 13:43:37 INFO - 'LOGNAME': 'cltbld', 13:43:37 INFO - 'MAIL': '/var/mail/cltbld', 13:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:37 INFO - 'MOZ_NO_REMOTE': '1', 13:43:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:37 INFO - 'NO_EM_RESTART': '1', 13:43:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:37 INFO - 'PWD': '/builds/slave/test', 13:43:37 INFO - 'SHELL': '/bin/bash', 13:43:37 INFO - 'SHLVL': '1', 13:43:37 INFO - 'TERM': 'linux', 13:43:37 INFO - 'TMOUT': '86400', 13:43:37 INFO - 'USER': 'cltbld', 13:43:37 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:37 INFO - '_': '/tools/buildbot/bin/python'} 13:43:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:37 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)) 13:43:37 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)) 13:43:37 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)) 13:43:37 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)) 13:43:37 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)) 13:43:37 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)) 13:43:37 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)) 13:43:37 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)) 13:43:37 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)) 13:43:37 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)) 13:43:37 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)) 13:43:37 INFO - Cleaning up... 13:43:37 INFO - Return code: 0 13:43:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:37 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 0x7f6e714e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, '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': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', '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 13:43:37 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 13:43:37 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 13:43:37 INFO - Using env: {'DISPLAY': ':0', 13:43:37 INFO - 'HOME': '/home/cltbld', 13:43:37 INFO - 'LANG': 'en_US.UTF-8', 13:43:37 INFO - 'LANGUAGE': 'en_US:en', 13:43:37 INFO - 'LOGNAME': 'cltbld', 13:43:37 INFO - 'MAIL': '/var/mail/cltbld', 13:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:37 INFO - 'MOZ_NO_REMOTE': '1', 13:43:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:37 INFO - 'NO_EM_RESTART': '1', 13:43:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:37 INFO - 'PWD': '/builds/slave/test', 13:43:37 INFO - 'SHELL': '/bin/bash', 13:43:37 INFO - 'SHLVL': '1', 13:43:37 INFO - 'TERM': 'linux', 13:43:37 INFO - 'TMOUT': '86400', 13:43:37 INFO - 'USER': 'cltbld', 13:43:37 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:37 INFO - '_': '/tools/buildbot/bin/python'} 13:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:38 INFO - Downloading/unpacking jsonschema 13:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:43:39 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 13:43:39 INFO - Downloading/unpacking functools32 (from jsonschema) 13:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:40 INFO - Downloading functools32-3.2.3-2.tar.gz 13:43:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:43:40 INFO - warning: no files found matching '*.txt' 13:43:40 INFO - no previously-included directories found matching 'build' 13:43:40 INFO - no previously-included directories found matching 'dist' 13:43:40 INFO - no previously-included directories found matching '.git*' 13:43:40 INFO - Installing collected packages: jsonschema, functools32 13:43:40 INFO - Running setup.py install for functools32 13:43:40 INFO - warning: no files found matching '*.txt' 13:43:40 INFO - no previously-included directories found matching 'build' 13:43:40 INFO - no previously-included directories found matching 'dist' 13:43:40 INFO - no previously-included directories found matching '.git*' 13:43:40 INFO - Successfully installed jsonschema functools32 13:43:40 INFO - Cleaning up... 13:43:40 INFO - Return code: 0 13:43:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:43:40 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')]} 13:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:40 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')]} 13:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:40 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 0x7f6e714e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, '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': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', '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 13:43:40 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 13:43:40 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 13:43:40 INFO - Using env: {'DISPLAY': ':0', 13:43:40 INFO - 'HOME': '/home/cltbld', 13:43:40 INFO - 'LANG': 'en_US.UTF-8', 13:43:40 INFO - 'LANGUAGE': 'en_US:en', 13:43:40 INFO - 'LOGNAME': 'cltbld', 13:43:40 INFO - 'MAIL': '/var/mail/cltbld', 13:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:40 INFO - 'MOZ_NO_REMOTE': '1', 13:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:40 INFO - 'NO_EM_RESTART': '1', 13:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:40 INFO - 'PWD': '/builds/slave/test', 13:43:40 INFO - 'SHELL': '/bin/bash', 13:43:40 INFO - 'SHLVL': '1', 13:43:40 INFO - 'TERM': 'linux', 13:43:40 INFO - 'TMOUT': '86400', 13:43:40 INFO - 'USER': 'cltbld', 13:43:40 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:40 INFO - '_': '/tools/buildbot/bin/python'} 13:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:40 INFO - Downloading/unpacking flake8 13:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:43:42 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 13:43:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:43:42 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 13:43:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 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 13:43:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:43:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:43:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:43:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:43:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:43:42 INFO - no previously-included directories found matching 'docs/_build' 13:43:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:43:42 INFO - Running setup.py install for pep8 13:43:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:43:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:43:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:43:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:43:42 INFO - no previously-included directories found matching 'docs/_build' 13:43:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:43:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:43:43 INFO - Cleaning up... 13:43:43 INFO - Return code: 0 13:43:43 INFO - Running post-action listener: _resource_record_post_action 13:43:43 INFO - Running post-action listener: _start_resource_monitoring 13:43:43 INFO - Starting resource monitoring. 13:43:43 INFO - ##### 13:43:43 INFO - ##### Running install step. 13:43:43 INFO - ##### 13:43:43 INFO - Running pre-action listener: _resource_record_pre_action 13:43:43 INFO - Running main action method: install 13:43:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:43:43 INFO - Reading from file tmpfile_stdout 13:43:43 INFO - Detecting whether we're running mozinstall >=1.0... 13:43:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:43:43 INFO - Reading from file tmpfile_stdout 13:43:43 INFO - Output received: 13:43:43 INFO - Usage: mozinstall [options] installer 13:43:43 INFO - Options: 13:43:43 INFO - -h, --help show this help message and exit 13:43:43 INFO - -d DEST, --destination=DEST 13:43:43 INFO - Directory to install application into. [default: 13:43:43 INFO - "/builds/slave/test"] 13:43:43 INFO - --app=APP Application being installed. [default: firefox] 13:43:43 INFO - mkdir: /builds/slave/test/build/application 13:43:43 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'] 13:43:43 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 13:43:57 INFO - Reading from file tmpfile_stdout 13:43:57 INFO - Output received: 13:43:57 INFO - /builds/slave/test/build/application/firefox/firefox 13:43:57 INFO - Running post-action listener: _resource_record_post_action 13:43:57 INFO - ##### 13:43:57 INFO - ##### Running run-tests step. 13:43:57 INFO - ##### 13:43:57 INFO - Running pre-action listener: _resource_record_pre_action 13:43:57 INFO - Running main action method: run_tests 13:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:43:57 INFO - Python 2.7.3 13:43:57 INFO - Return code: 0 13:43:57 INFO - grabbing minidump binary from tooltool 13:43: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')]} 13:43:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10570b0>, '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 0x1057fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:43:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:43:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:43:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:43:57 INFO - Return code: 0 13:43:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:43:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:43:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:43:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:43:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:43:58 INFO - Return code: 0 13:43:58 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/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test/build 13:43:58 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/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 13:43:58 INFO - Using env: {'DISPLAY': ':0', 13:43:58 INFO - 'HOME': '/home/cltbld', 13:43:58 INFO - 'LANG': 'en_US.UTF-8', 13:43:58 INFO - 'LANGUAGE': 'en_US:en', 13:43:58 INFO - 'LOGNAME': 'cltbld', 13:43:58 INFO - 'MAIL': '/var/mail/cltbld', 13:43:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:43:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:58 INFO - 'MOZ_NO_REMOTE': '1', 13:43:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:58 INFO - 'NO_EM_RESTART': '1', 13:43:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:58 INFO - 'PWD': '/builds/slave/test', 13:43:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:43:58 INFO - 'SHELL': '/bin/bash', 13:43:58 INFO - 'SHLVL': '1', 13:43:58 INFO - 'TERM': 'linux', 13:43:58 INFO - 'TMOUT': '86400', 13:43:58 INFO - 'USER': 'cltbld', 13:43:58 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985', 13:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:58 INFO - '_': '/tools/buildbot/bin/python'} 13:43:58 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/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 13:43:59 INFO - mozversion INFO | application_buildid: 20151216130002 13:43:59 INFO - mozversion INFO | application_changeset: 1e8421b447c4e1034f54d6a520525fefd8412f45 13:43:59 INFO - mozversion INFO | application_display_name: Nightly 13:43:59 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:43:59 INFO - mozversion INFO | application_name: Firefox 13:43:59 INFO - mozversion INFO | application_remotingname: firefox 13:43:59 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:43:59 INFO - mozversion INFO | application_vendor: Mozilla 13:43:59 INFO - mozversion INFO | application_version: 46.0a1 13:43:59 INFO - mozversion INFO | platform_buildid: 20151216130002 13:43:59 INFO - mozversion INFO | platform_changeset: 1e8421b447c4e1034f54d6a520525fefd8412f45 13:43:59 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:43:59 INFO - mozversion INFO | platform_version: 46.0a1 13:43:59 INFO - 2015-12-16 13:43:59,097 DEBUG : using testdate: 1450302239 13:43:59 INFO - 2015-12-16 13:43:59,097 DEBUG : actual date: 1450302239 13:43:59 INFO - 2015-12-16 13:43:59,108 INFO : starting webserver on 'localhost:52218' 13:43:59 INFO - 2015-12-16 13:43:59,109 INFO : Starting test suite talos-linux64-ix-028.e 13:43:59 INFO - 2015-12-16 13:43:59,109 INFO : Starting test dromaeo_css 13:43:59 INFO - 2015-12-16 13:43:59,109 DEBUG : operating with platform_type : linux_ 13:43:59 INFO - 2015-12-16 13:43:59,110 INFO : Initialising browser for dromaeo_css test... 13:43:59 INFO - 2015-12-16 13:43:59,125 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjnHiAJ/profile http://localhost:52218/getInfo.html 13:44:03 INFO - 2015-12-16 13:44:03,482 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:44:03 INFO - 2015-12-16 13:44:03,483 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:44:03 INFO - 2015-12-16 13:44:03,483 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:44:03 INFO - 2015-12-16 13:44:03,483 DEBUG : BROWSER_OUTPUT: __metrics 13:44:03 INFO - 2015-12-16 13:44:03,624 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] 13:44:04 INFO - 2015-12-16 13:44:04,525 INFO : Browser initialized. 13:44:04 INFO - 2015-12-16 13:44:04,526 INFO : Running cycle 1/1 for dromaeo_css test... 13:44:04 INFO - 2015-12-16 13:44:04,526 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjnHiAJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:44:16 INFO - 2015-12-16 13:44:16,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 143323136 13:44:16 INFO - 2015-12-16 13:44:16,490 DEBUG : BROWSER_OUTPUT: 13:45:06 INFO - 2015-12-16 13:45:06,131 DEBUG : BROWSER_OUTPUT: 1450302306125 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] 13:47:17 INFO - 2015-12-16 13:47:17,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52218/tests/dromaeo/cssquery-ext.html) 13:47:18 INFO - 2015-12-16 13:47:18,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 145735680 13:47:18 INFO - 2015-12-16 13:47:18,985 DEBUG : BROWSER_OUTPUT: 13:50:21 INFO - 2015-12-16 13:50:21,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-ext.html (next: http://localhost:52218/tests/dromaeo/cssquery-jquery.html) 13:50:21 INFO - 2015-12-16 13:50:21,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 144412672 13:50:21 INFO - 2015-12-16 13:50:21,649 DEBUG : BROWSER_OUTPUT: 13:53:23 INFO - 2015-12-16 13:53:23,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52218/tests/dromaeo/cssquery-mootools.html) 13:53:24 INFO - 2015-12-16 13:53:24,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 145145856 13:53:24 INFO - 2015-12-16 13:53:24,058 DEBUG : BROWSER_OUTPUT: 13:56:25 INFO - 2015-12-16 13:56:25,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52218/tests/dromaeo/cssquery-prototype.html) 13:56:26 INFO - 2015-12-16 13:56:26,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 143998976 13:56:26 INFO - 2015-12-16 13:56:26,368 DEBUG : BROWSER_OUTPUT: 13:59:29 INFO - 2015-12-16 13:59:29,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52218/tests/dromaeo/cssquery-yui.html) 13:59:29 INFO - 2015-12-16 13:59:29,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 145076224 13:59:29 INFO - 2015-12-16 13:59:29,643 DEBUG : BROWSER_OUTPUT: 14:02:32 INFO - 2015-12-16 14:02:32,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-yui.html (next: http://localhost:52218/tests/dromaeo/cssquery-dojo.html) 14:02:32 INFO - 2015-12-16 14:02:32,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 146874368 14:02:32 INFO - 2015-12-16 14:02:32,458 DEBUG : BROWSER_OUTPUT: 14:02:32 INFO - 2015-12-16 14:02:32,458 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:02:32 INFO - 2015-12-16 14:02:32,458 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:02:32 INFO - 2015-12-16 14:02:32,458 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:02:32 INFO - 2015-12-16 14:02:32,458 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:02:32 INFO - 2015-12-16 14:02:32,460 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2678.491086693528;2724.7139050399696;2757.669079710435;2767.142185922364;2779.8332100074003;4590.150822097914;4771.260454629533;4861.124957629656;4876.756162191885;4906.141425250585;4753.073150735608;4761.309610106532;4789.401324834395;4797.592204662599;4800.519948005198;4420.602145806877;4472.552744725534;4473.418455600784;4486.2821948488245;4513.548645135476;4486.237339652251;4516.299973504096;4540.432445944257;4540.841070562531;4579.839705610304;4286.185624731291;4370;4446.444194475691;4485.529019452975;4539.523350048247;4426.136903303857;4454.799534020977;4460.955390446086;4464.7321160730135;4496.7301961882395;4265.765382903939;4396.054848207618;4443.844465443726;4444.599881090968;4472.127935052666;4629.444466663988;4650.9069818603775;4650.930236046462;4658.883527911796;4720.811167553294;5053.722045287508;5164.509371609691;5169.043726910533;5174.09453345663;5186.507281808223;5179.870503237412;5185.222216667492;5186.636935414523;5191.558717509016;5196.636235463519;4636.9536304637195;4706.388169537938;4769.2607645814605;4812.542808433193;4862.586680132157;5316.840494785085;5321.228421878806;5330.760115794798;5333.253344531769;5377.274068000848;4825.95174048255;5103.719295438712;5105.0810854045885;5115.232715092691;5128.589712822965;5064.240363945364;5106.131957567222;5129.3075434816565;5130.127878260705;5213.348331458567;5131.2559678846355;5151.098557752453;5156.716380599028;5158.535731784157;5197.97401013;4874.46380898101;5023.623228257895;5121.155009423478;5122.692638441706;5130.51260130287;4174.08170202555;4210.831566737357;4243.151369726067;4275.636570891447;4277.315629499265;3700.0564855961557;3723.77657340555;3726.087108658342;3736.5889752127246;3772.2266935278203;4351.891202719894;4398.142362239332;4439.134368798053;4452.398926144993;4474.418325617714;5127.769250383742;5142.87142821425;5158.613104017214;5158.942416804546;5187.066328060985;4480.708753930984;4481.305397663367;4488;4498.167838949805;4533.274676051816;4323.308270676739;4387.100644367897;4451;4468.21806183923;4566.06395688883;4820.71075735457;4858.05267972742;4878.317035615017;4898.118338699069;4939;5144.6913185209005;5160.071187186342;5175.249588809676;5176.456472070529;5192.532672059533;4723.173444647105;4840.443349014909;4841.927371089507;4956.033573453286;4956.752162391794;5093.388793344822;5095.745212739423;5117;5127.871803204801;5168.58651307887;5191.480851914778;5195.350581177353;5199.74001299941;5203.271541984201;5208.73956302191;4736.265878788656;4888.169011268022;4888.95111048885;4986.102501549756;5016.498350164954;4984.775685094107;5019.974900125476;5027.371578552681;5043.773030213722;5047.722375269395;4700.130475861976;4896;4927.852164435073;4935.235038569028;4952.801887924443;4925;4968.776405061853;5011.624128190473;5028.145215313479;5085.669431486942;4910.214365701613;4951.306817045688;4953.281774142802;4960.503949605155;4996.550310472075 14:02:32 INFO - 2015-12-16 14:02:32,463 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.9500980671049;568.3747877334931;571.8941995730787;578.1616655849017;614.1340709599466;35314.82342588287;36179.63820361796;36271.09322266945;36279.4558081629;36369.54521819128;36368.81815590918;36863.26273474529;36926;36930.07674808131;37005.81497092511;7755.806104847367;7915.52506849588;7917.208279172094;7924.405669574776;7928.722494712686;7627.122880868688;7735.497192682486;7753.922460775377;7790.493617914817;7795.766127016199;7838.529688218725;7891.250331218554;7892.56590887501;7895.092064412609;7904.367650587968;7807.804804879895;7831.921680783176;7857.528548287121;7912.327452166573;7919.326857217144;7650.655720492591;7808;7811.414143939227;7820.139784623687;7843.37253019757;33642.1589460263;33965.32069358624;33973.490397644055;34044.957302561925;34079.14802129942;2837.4466978939117;2979.8063125896747;3060.908172754821;3090.90727278182;3242.789218700777;27175.45649087027;27245.86377068122;27713.030043948365;27812;28151.155465336073;3267.738580913521;3288.2765791525826;3297.258116923673;3416.1288871337897;3454.6199918008997;201838;202124;202849;203045;203225;50308.49691503038;51139;52064.739676301375;52268.73865630647;52770.20844687333;53659;53677.463225367246;53804.730976344865;53828.730856345464;53892.461075389525;14091.577252682437;14464.493742718954;14476.493322733864;14484.34820433083;14498.85501144975;9985.750356241153;10063.245256605784;10077;10077.596896124072;10078.697639070839;17830;18191.45425637233;18217.271309147487;18229.7265541017;18287.81712182861;7666.425018123663;7923.286904178652;7981.241782030698;8025.2777250047775;8033.277005069572;872.6334939325499;873.7728190670472;897.9191872731485;966.1932286540817;1007.6725064354114;24904.875475622506;25517.87241063783;25690.871545642527;25693.229203123938;25912.352191195372;939.1359948847077;977.3647129365827;1024.283001898659;1063.7606538528769;1124.4714983957526;13281.667958300926;13436.925045996297;13562.93218533901;13586.93206533961;13632.386542605607;257808;260606;261126;261890;263660;44459.11081778411;44537.33194002092;44566.77716611461;45039;45103.32345014827;1222.4010234984794;1233.2785320587557;1234.4383305595932;1248.7752204603078;1252.1422825364655;25079.373015674755;25443.61834572446;25559.10543131056;25625.615615765404;25711;39679.60320396759;39996.40005399863;40112.799436002635;40141.79929100453;40152.598474014885;244928;245986;246157;248736;250005;28560.285992850346;29082.41835163327;29129.417411651226;29139;29162.854185728935;33532.49701254434;33539.83230083834;33910.15224619404;34297;34316.31367372689;28893.855530722212;28977.42045159127;29452;29516.262093447836;29718.851405742833;30991.69008309888;31593.5260971081;31826.681733182373;32128.19679508031;32362.676373235965;32943.176420588716;32999.67000330062;33264;33507;33898.152546186546;26798;27739.72260277452;29665.25836854096;30036.849815750782;30101.849490752407;22688.546229075655;22925.88537057304;23035.424114396603;23166;23277.883610581837 14:02:32 INFO - 2015-12-16 14:02:32,463 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.5730337078652;341.812003398131;341.81883601691095;342.3888359278688;342.73438085483747;14845.331960061796;15095.849041509595;15921.442749503754;16003.679926401464;16717;9963.15313198379;10213.897861021387;14249.572512824607;15856;15869.841301586981;4417.1607394595;4514.593686568208;4717.433907931053;5125.564327032188;5133.691978481284;5110.693358398489;5134.691918484884;5135.614828887829;5136.794528218886;5153.871153221162;3443;4928.162212423897;5101.362329708786;5105.081085404626;5192.454792246816;5044.344235249431;5074.847754567369;5083.567896728782;5089.160288552384;5154.974225128869;4947.307376967227;4974.10466116099;4986.800527978877;5081.822136225252;5086.898262034739;11260.324380537111;11497.770044599061;13546.983976201824;19183;19344.32294869687;1796.694561924463;1825.9087045647798;1828.3692126216433;1910.0545230111184;1957.862949593529;8895;9114.77213069672;11187.944060279728;12850.742985140338;12968.740625187538;1720.7246840505459;1722.9834397705415;1733.306677329066;1808.21342715919;1837.3752924005903;52838;54235.457645423434;54881.45118548803;57453.13820292699;57974.71012644952;9793.87370452407;9943.154831839374;9986.800263994824;10053.296269261227;10064.748381290527;12608;12687.619371418872;12694.238345699288;12707.237565746085;12747.872521274669;7164;7170.067891174114;7193.568385896863;7264.745733899288;7339.266073392725;6810.489213309022;6822.11312529368;6834.384905358542;6834.931650683529;6850.725970961105;4277.165952639268;4282.850100246476;4286.5070516890955;4307.375430562551;4317.201317756225;1617.2398972482915;1657.4033347994712;1663.0853030832993;1698.230595027753;1720.91395430228;363.7144841299567;366.76893557058884;406.73968660057585;836.188896770132;852.8123812761182;8999.37004409698;9000.63997440095;9561.760955976017;9598.232141428669;9794.853077203848;392.54464820807726;404.19968462444524;406.2991339938582;406.7031067320813;414.73456987528004;5312.946870531323;5368.892622147613;5369.114096174166;5371.75827087782;5382.192671099367;449809;460304;465595;466917;471246;67215.3278467209;68861.65569172222;69007.65496172487;69380;69404.30595693979;444.54434204940196;447.0678635045966;447.6172872194292;447.7604481602327;448.85636596288873;8703.43427677199;8874.423162494417;8935.463872167691;8968.506732129796;9016.594253258489;28956.710432896245;29033.564496532148;29229;29448.852755736083;30284.69715302907;43557.78221109001;44536.109277813615;44922.550774491836;45079.32381014222;45534.772326138154;8763.649454021768;8957.193852553302;9003.594838232426;9011.279097672039;9013.729588112366;10121.443320617436;15671.843281567495;15901.761473577673;16411.91794041022;16454.670906581563;13189.868101318863;13332.800007999695;13587.52443664467;13714.725705486035;13832.515861944783;12683.556075537312;13062.738745225231;13185.736285274432;13636.181829090287;13711.862881371457;13902.443902243796;14641.853581464475;14650.267486625413;14725.116493010453;14834.554963351116;8454.323654107533;8567.314614830922;8898.42160259581;9192.632294708405;9194.632214711337;9429.858552121861;10724.678259652223;14009.229492378017;14234.786478202628;14290.857091428952 14:02:32 INFO - 2015-12-16 14:02:32,467 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1489.3223583269614;1695.5083025922484;1740.5909611241364;1765.6292178642489;1768.3899054826088;6096.390360963901;6242.531810114248;7002.369786719194;7414.369778568828;7452.888206676904;6751.966240168805;6923.446124310056;6993.195782485016;6997.1253593300835;7021.68402421891;2089.4880754215237;2127.9468013299715;2130.0947097483586;2131.4458240857334;2132.8720276783365;2052.4253209101403;2060.7115003899467;2067.03882694547;2070.6272870883236;2076.636588596997;2032.2277534536856;2033;2034.9898250508727;2046.9867415629285;2055.1779288284656;2073.78225286345;2091.613051585454;2094.5077906691913;2098.6642137257963;2098.8425868059803;2075.2217918280644;2082.7188329575465;2111.883846388448;2115.23851413491;2129.1057755742627;7189.8202544936275;7257.854842903165;7266.672999715025;7274.054372931485;7280.927190728078;4199.91600167995;4213.494380674308;4220.78896055196;4222.535521092708;4243.299855523835;2725.8773355198864;2736.822106563067;2780.124260857823;2850.3016760893506;2852.386736851566;888.311558542135;1740.712782390904;1750.9212085456186;1760.287083731091;1775.2189036823886;9507.429554226768;9604.471754053524;9633.421994680342;9633.759156021086;9654.806903861954;3782.6973842092566;3820.312343778091;3832.137769001952;3878.3019056569524;3915.0212446888277;7698.422618303538;7726.072871255486;7742.729004484816;7751.302382785577;7760.805979850549;4180.519240287345;4216.47294088239;4225.619694227535;4226.344916537942;4228.1966426378885;3823.25446537928;3892.6885849132;3914.2171565686976;3928.2929072766606;3932;3280.097973057428;3304.5869266341706;3304.669533046724;3325.384803811254;3348.3135957129216;957.3585697582637;957.8467445208734;968.9854652180223;974.6150270643057;981.6711401680517;1087.380193289833;1105.209775010871;1106.336198281041;1234.216272666863;1234.6481252842896;6691.230508491586;6812.284710105467;6815.079964204868;6838.760643377458;6840.555363901331;398.92420440116285;399.9400089986525;400.31945692322586;400.6754528831656;407.2404964740737;5456.236126942231;5469.808556700496;5495.560355171577;5509.311336082989;5520.199571062254;8632.223099920911;8700.738977830675;8814.162654547808;8863.955680221687;8880.8667869982;8716.215540601377;8717;8719.04090550039;8720.520371379509;8743.562821859008;6591.176102987127;6735.191776986793;6819.795406137824;6894.448444124458;6903.930960690429;6768;6806.319368063154;6827.04421381017;6836.794896153124;6837.589744615339;7644.80887977805;7651.693932242648;7840.647170877438;7902.920970790218;7913.564753938358;7777.3778097753175;7952.165022672536;7986.081600615771;8007.959960200162;8012.679492820222;5281.181416880389;5434.701091440009;6290.905636415366;6333.429991300805;6341.334159913143;6708.83227919306;6709.832254193684;6747.055412242388;6755.392014718699;6760.93239067603;6123.295820980644;6295.779647712308;6350.523710721622;6489.480841532761;6544.509161812978;6122.081687746873;6180.938190618216;6210.813675589739;6285.685715714288;6304.779332723333;6341.112244285896;6371.203599550056;6390.968045159744;6427.421532062137;6430.807075787734;5885.028970219866;5986.281646202484;5987.371326010706;6011.489023432882;6019.18740969981;5983.282006159288;6035.456808887221;6056.7274472649715;6058.151858739692;6066.939330606638 14:02:32 INFO - 2015-12-16 14:02:32,467 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.4623862002875;309.11438728044146;313.84151003743114;314.4873160099918;315.75686721224645;5587.552995760335;5660.716964151787;5678.460546248105;5691.857703557408;5695;5548.944510554893;5551.528120109796;5575.163725441186;5585.636933599313;5596.692181929992;4177;4256.574342565734;4284.550122237167;4296.226679197735;4328.177646247219;4215.135897141079;4240.363945408182;4261.744295342274;4276.957230427703;4281.785910704468;4203.453551038361;4212.8314867405425;4224.683148763855;4225.112726327475;4232.915341693164;4209.831606735727;4215.156968606291;4225.535191128974;4260.08408192237;4265.402843601898;3650.4524321351746;3689.7786132832116;3702.426123950792;3722.5346831646043;3726.329260733067;5277.656952298088;5422;5422.783088676449;5428.538574221196;5444.646098003617;4915.3855768029;4918.926216106761;4919.016196760662;4922.064807686528;4924.630652701062;5916.615419997729;5923.911141332884;5927.822165335004;5933.821985340447;5936.7328470218945;3912.628300311466;4027.3958906164016;4036.777977211252;4056.4726585543985;4057.918841623151;6178.351273116348;6197.0704394340755;6232.657203853786;6236.126942228092;6238.719257633372;4115.444415003996;4132.979335103305;4148.43996060534;4152.27335216342;4166.500019997619;4196.202721482909;4202.159568086395;4213.136307057046;4214.325707886724;4218.49378074633;4707.905841883143;4719.480857105716;4870.391201099863;4875.195592727231;4882.658213925062;5899.46904778572;5906.114082887601;5911.467967882825;5913.231279933667;5934.8813023739285;1454.8545145485366;1499.9050692994176;1501.0918394371467;1502.6919481506266;1505.789189513469;994.6021591363512;1003.5985605757755;1011.6914341126027;1021.2289721260549;1023.8413045977885;5148.562372198405;5153.3558305211845;5157;5157.948420515821;5161.66449180802;6118.663473508911;6142.539309551801;6150.630962142286;6163.260408750979;6166.229221347332;5120.231965205175;5140.254663073833;5141.665791723526;5146.8970620588125;5151.201563757623;3219.806811591312;3300.801951882847;3319;3333.283344081034;3334.0997930558615;5796.565257605696;5851.239338885917;5865.970670146622;5869.853253668607;5885.264341957255;6389.201349831271;6396.552241343062;6409.935900640934;6411.487081033506;6423.518236132309;5684.8294551163535;5847.853803654943;5849.795257165979;5855.268091488564;5859.794907178229;6177.567570270038;6180.6909654517995;6183.443490085914;6186.412290832363;6203.534734894811;6015.518758499397;6019.819405417845;6058.0912863069125;6059.151718759289;6067.666278354733;5716.828495145152;5845.766169353178;5847.8245652630485;5849.94150058494;5850.0932355484965;4193.517745459311;4269.423627810206;4292.806823692878;4295.506016807982;4304.127704448575;5920.37836027211;6077.787277445268;6096.634201947897;6105.9694701526205;6120.051392034242;5729.598928074995;5844.912326315024;5846.152307915413;5860.677662728591;5877.471027607536;5884.32330282023;5904.409559044061;5909.261342332208;5915.260592425947;5917.792877249276;5629.08611072221;5726.997775389374;5749.8562535936935;5769.624974376652;5770.855728606651;5953.345132035559;5953.553483488669;5967.522598192048;5968.104784282393;5991.981363168359;5743.483086522233;5767.711614419346;5809.9419005809405;5830.5627077968475;5836.970815145897 14:02:32 INFO - 2015-12-16 14:02:32,470 DEBUG : BROWSER_OUTPUT: |5;yui.html;688.8725585766632;711.3100292716067;725.2783480436963;739.9936086921786;790.6165509727784;12310.753784924296;12317.322547259897;12320.075994300418;12329.568465103723;12349.506019759221;11019.669409917695;11135.220534562584;11160.274582152155;11210.607628732996;11224.943875280613;623.4295619508144;625.1373105114935;789.838083192944;799.8640231160688;802.2859654907137;801.2428255298715;805.1827395193883;807.1484583764127;807.5154907055748;808.5633757770797;839.3704721458906;854.7264875239925;855.0338117926734;855.670566831768;856.0839901305606;843.1399972028557;843.2705709561246;846.2468403121227;846.6147902704286;847;624.5409623926456;626.7273735924841;627.0374974414298;627.1032423634201;627.5920651576466;11000.834987475195;11046.116310695206;11076.889231107747;11130.276532025473;11175.441227938652;10601.78796424075;11109.222354435193;11249.60626378081;11372.37451940143;11403.144764142722;9407.153356197907;9526.9523652382;9550.61797528098;9580.616775329048;9590.6643267486;3129.687031296875;3149.0395429394025;3165.319456316903;3304.867805287786;3404.1659793350786;37063.258734825155;37089.814550927615;37491.167835995475;37719.43420848689;37807.62192378069;9195.172434480928;9201.585928633227;9262.629494820132;9386.155246027754;9451.432914025181;15887.205639717968;16032.278547465392;16064.598385040468;16689.165541722865;16727.91636041812;6519.511036672268;6542.443892269115;6596.868062638816;6606.86786264272;6725.19297684281;3455.326211388755;3485.3224790904956;3487;3516.82415879205;3532.6290739472497;2539.21284401836;2567.9743202567734;2576.4975829713026;2598.3244356467453;2602.0632572273967;462.30192409461955;471.78062201076665;478.4497827498405;479.5516192360154;480.86776136562025;579.6174524813687;592.1295695327861;600.5795942839942;622.9689863276285;631.6904716688789;7372.336489715844;7669.923300766921;7740.225977402215;7812.84374312522;7965.761027169194;558.4359796605377;595.8004068637055;630.9305976342598;641.9197600299963;648.3192647719875;3600.58593261773;3725.273571653556;3859.4789703390243;3878.5151856017997;3892.2215556888737;47242;47595;47834.521654783006;47849.5215047852;47852.28221576679;44387.77806111013;44871.326930096075;48097.75951120222;48668.51331486711;49186.75406622944;38123.42814857779;38451.57806852192;38540.6145938537;40381.394279085835;40657.79671101626;7732.613369331399;8140.877886831584;8401.789955251168;8500.617472213642;8525.573721314033;31086.53370199494;31822.6817731829;32154.67845321517;32431.675683242865;32656;35880.282394351445;37791;39950;40552.391714123725;40634;9981.251406144424;10098.293119481566;10147.898521014991;10186.337888037255;10279.588816447558;11298.943505282421;11387.715307117389;11419.771604568028;11479.36863472517;12128.332941688292;10469.790604188025;10887.618933337295;11056.613018544313;11068.391238481961;11189.944050280023;10582.153427725918;10645.361278323326;10681.51933162994;11099;11137.777244455228;9770.853437198306;10720.410377429316;10883.292585981886;11127.109831213646;11147.219694621299;9074.637014519609;9110.10919548831;9233.353665243369;9266.629334826801;9287.396319239228;9144.542772861198;9351.953240233755;9381.343305968516;9521.19069879068;9666.565004574952 14:02:32 INFO - 2015-12-16 14:02:32,470 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:02:32 INFO - 2015-12-16 14:02:32,470 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,334 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: __startTimestamp1450303352456__endTimestamp 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4745.26 Median:4876.76 stddev:502.41 (10.3%) stddev-sans-first:477.07 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: Values: 2678.5 2724.7 2757.7 2767.1 2779.8 4590.2 4771.3 4861.1 4876.8 4906.1 4753.1 4761.3 4789.4 4797.6 4800.5 4420.6 4472.6 4473.4 4486.3 4513.5 4486.2 4516.3 4540.4 4540.8 4579.8 4286.2 4370.0 4446.4 4485.5 4539.5 4426.1 4454.8 4461.0 4464.7 4496.7 4265.8 4396.1 4443.8 4444.6 4472.1 4629.4 4650.9 4650.9 4658.9 4720.8 5053.7 5164.5 5169.0 5174.1 5186.5 5179.9 5185.2 5186.6 5191.6 5196.6 4637.0 4706.4 4769.3 4812.5 4862.6 5316.8 5321.2 5330.8 5333.3 5377.3 4826.0 5103.7 5105.1 5115.2 5128.6 5064.2 5106.1 5129.3 5130.1 5213.3 5131.3 5151.1 5156.7 5158.5 5198.0 4874.5 5023.6 5121.2 5122.7 5130.5 4174.1 4210.8 4243.2 4275.6 4277.3 3700.1 3723.8 3726.1 3736.6 3772.2 4351.9 4398.1 4439.1 4452.4 4474.4 5127.8 5142.9 5158.6 5158.9 5187.1 4480.7 4481.3 4488.0 4498.2 4533.3 4323.3 4387.1 4451.0 4468.2 4566.1 4820.7 4858.1 4878.3 4898.1 4939.0 5144.7 5160.1 5175.2 5176.5 5192.5 4723.2 4840.4 4841.9 4956.0 4956.8 5093.4 5095.7 5117.0 5127.9 5168.6 5191.5 5195.4 5199.7 5203.3 5208.7 4736.3 4888.2 4889.0 4986.1 5016.5 4984.8 5020.0 5027.4 5043.8 5047.7 4700.1 4896.0 4927.9 4935.2 4952.8 4925.0 4968.8 5011.6 5028.1 5085.7 4910.2 4951.3 4953.3 4960.5 4996.6 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39142.20 Median:18120.22 stddev:62023.76 (342.3%) stddev-sans-first:62130.11 14:02:32 INFO - 2015-12-16 14:02:32,471 DEBUG : BROWSER_OUTPUT: Values: 563.0 568.4 571.9 578.2 614.1 35314.8 36179.6 36271.1 36279.5 36369.5 36368.8 36863.3 36926.0 36930.1 37005.8 7755.8 7915.5 7917.2 7924.4 7928.7 7627.1 7735.5 7753.9 7790.5 7795.8 7838.5 7891.3 7892.6 7895.1 7904.4 7807.8 7831.9 7857.5 7912.3 7919.3 7650.7 7808.0 7811.4 7820.1 7843.4 33642.2 33965.3 33973.5 34045.0 34079.1 2837.4 2979.8 3060.9 3090.9 3242.8 27175.5 27245.9 27713.0 27812.0 28151.2 3267.7 3288.3 3297.3 3416.1 3454.6 201838.0 202124.0 202849.0 203045.0 203225.0 50308.5 51139.0 52064.7 52268.7 52770.2 53659.0 53677.5 53804.7 53828.7 53892.5 14091.6 14464.5 14476.5 14484.3 14498.9 9985.8 10063.2 10077.0 10077.6 10078.7 17830.0 18191.5 18217.3 18229.7 18287.8 7666.4 7923.3 7981.2 8025.3 8033.3 872.6 873.8 897.9 966.2 1007.7 24904.9 25517.9 25690.9 25693.2 25912.4 939.1 977.4 1024.3 1063.8 1124.5 13281.7 13436.9 13562.9 13586.9 13632.4 257808.0 260606.0 261126.0 261890.0 263660.0 44459.1 44537.3 44566.8 45039.0 45103.3 1222.4 1233.3 1234.4 1248.8 1252.1 25079.4 25443.6 25559.1 25625.6 25711.0 39679.6 39996.4 40112.8 40141.8 40152.6 244928.0 245986.0 246157.0 248736.0 250005.0 28560.3 29082.4 29129.4 29139.0 29162.9 33532.5 33539.8 33910.2 34297.0 34316.3 28893.9 28977.4 29452.0 29516.3 29718.9 30991.7 31593.5 31826.7 32128.2 32362.7 32943.2 32999.7 33264.0 33507.0 33898.2 26798.0 27739.7 29665.3 30036.8 30101.8 22688.5 22925.9 23035.4 23166.0 23277.9 14:02:32 INFO - 2015-12-16 14:02:32,472 DEBUG : BROWSER_OUTPUT: 14:02:32 INFO - 2015-12-16 14:02:32,472 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24976.45 Median:22491.59 stddev:75681.40 (336.5%) stddev-sans-first:75871.10 14:02:32 INFO - 2015-12-16 14:02:32,472 DEBUG : BROWSER_OUTPUT: Values: 341.6 341.8 341.8 342.4 342.7 14845.3 15095.8 15921.4 16003.7 16717.0 9963.2 10213.9 14249.6 15856.0 15869.8 4417.2 4514.6 4717.4 5125.6 5133.7 5110.7 5134.7 5135.6 5136.8 5153.9 3443.0 4928.2 5101.4 5105.1 5192.5 5044.3 5074.8 5083.6 5089.2 5155.0 4947.3 4974.1 4986.8 5081.8 5086.9 11260.3 11497.8 13547.0 19183.0 19344.3 1796.7 1825.9 1828.4 1910.1 1957.9 8895.0 9114.8 11187.9 12850.7 12968.7 1720.7 1723.0 1733.3 1808.2 1837.4 52838.0 54235.5 54881.5 57453.1 57974.7 9793.9 9943.2 9986.8 10053.3 10064.7 12608.0 12687.6 12694.2 12707.2 12747.9 7164.0 7170.1 7193.6 7264.7 7339.3 6810.5 6822.1 6834.4 6834.9 6850.7 4277.2 4282.9 4286.5 4307.4 4317.2 1617.2 1657.4 1663.1 1698.2 1720.9 363.7 366.8 406.7 836.2 852.8 8999.4 9000.6 9561.8 9598.2 9794.9 392.5 404.2 406.3 406.7 414.7 5312.9 5368.9 5369.1 5371.8 5382.2 449809.0 460304.0 465595.0 466917.0 471246.0 67215.3 68861.7 69007.7 69380.0 69404.3 444.5 447.1 447.6 447.8 448.9 8703.4 8874.4 8935.5 8968.5 9016.6 28956.7 29033.6 29229.0 29448.9 30284.7 43557.8 44536.1 44922.6 45079.3 45534.8 8763.6 8957.2 9003.6 9011.3 9013.7 10121.4 15671.8 15901.8 16411.9 16454.7 13189.9 13332.8 13587.5 13714.7 13832.5 12683.6 13062.7 13185.7 13636.2 13711.9 13902.4 14641.9 14650.3 14725.1 14834.6 8454.3 8567.3 8898.4 9192.6 9194.6 9429.9 10724.7 14009.2 14234.8 14290.9 14:02:32 INFO - 2015-12-16 14:02:32,472 DEBUG : BROWSER_OUTPUT: 14:02:32 INFO - 2015-12-16 14:02:32,472 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4990.98 Median:6081.66 stddev:2569.42 (42.2%) stddev-sans-first:2563.15 14:02:32 INFO - 2015-12-16 14:02:32,472 DEBUG : BROWSER_OUTPUT: Values: 1489.3 1695.5 1740.6 1765.6 1768.4 6096.4 6242.5 7002.4 7414.4 7452.9 6752.0 6923.4 6993.2 6997.1 7021.7 2089.5 2127.9 2130.1 2131.4 2132.9 2052.4 2060.7 2067.0 2070.6 2076.6 2032.2 2033.0 2035.0 2047.0 2055.2 2073.8 2091.6 2094.5 2098.7 2098.8 2075.2 2082.7 2111.9 2115.2 2129.1 7189.8 7257.9 7266.7 7274.1 7280.9 4199.9 4213.5 4220.8 4222.5 4243.3 2725.9 2736.8 2780.1 2850.3 2852.4 888.3 1740.7 1750.9 1760.3 1775.2 9507.4 9604.5 9633.4 9633.8 9654.8 3782.7 3820.3 3832.1 3878.3 3915.0 7698.4 7726.1 7742.7 7751.3 7760.8 4180.5 4216.5 4225.6 4226.3 4228.2 3823.3 3892.7 3914.2 3928.3 3932.0 3280.1 3304.6 3304.7 3325.4 3348.3 957.4 957.8 969.0 974.6 981.7 1087.4 1105.2 1106.3 1234.2 1234.6 6691.2 6812.3 6815.1 6838.8 6840.6 398.9 399.9 400.3 400.7 407.2 5456.2 5469.8 5495.6 5509.3 5520.2 8632.2 8700.7 8814.2 8864.0 8880.9 8716.2 8717.0 8719.0 8720.5 8743.6 6591.2 6735.2 6819.8 6894.4 6903.9 6768.0 6806.3 6827.0 6836.8 6837.6 7644.8 7651.7 7840.6 7902.9 7913.6 7777.4 7952.2 7986.1 8008.0 8012.7 5281.2 5434.7 6290.9 6333.4 6341.3 6708.8 6709.8 6747.1 6755.4 6760.9 6123.3 6295.8 6350.5 6489.5 6544.5 6122.1 6180.9 6210.8 6285.7 6304.8 6341.1 6371.2 6391.0 6427.4 6430.8 5885.0 5986.3 5987.4 6011.5 6019.2 5983.3 6035.5 6056.7 6058.2 6066.9 14:02:32 INFO - 2015-12-16 14:02:32,472 DEBUG : BROWSER_OUTPUT: 14:02:32 INFO - 2015-12-16 14:02:32,472 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4881.37 Median:5563.35 stddev:1459.45 (26.2%) stddev-sans-first:1422.56 14:02:32 INFO - 2015-12-16 14:02:32,473 DEBUG : BROWSER_OUTPUT: Values: 305.5 309.1 313.8 314.5 315.8 5587.6 5660.7 5678.5 5691.9 5695.0 5548.9 5551.5 5575.2 5585.6 5596.7 4177.0 4256.6 4284.6 4296.2 4328.2 4215.1 4240.4 4261.7 4277.0 4281.8 4203.5 4212.8 4224.7 4225.1 4232.9 4209.8 4215.2 4225.5 4260.1 4265.4 3650.5 3689.8 3702.4 3722.5 3726.3 5277.7 5422.0 5422.8 5428.5 5444.6 4915.4 4918.9 4919.0 4922.1 4924.6 5916.6 5923.9 5927.8 5933.8 5936.7 3912.6 4027.4 4036.8 4056.5 4057.9 6178.4 6197.1 6232.7 6236.1 6238.7 4115.4 4133.0 4148.4 4152.3 4166.5 4196.2 4202.2 4213.1 4214.3 4218.5 4707.9 4719.5 4870.4 4875.2 4882.7 5899.5 5906.1 5911.5 5913.2 5934.9 1454.9 1499.9 1501.1 1502.7 1505.8 994.6 1003.6 1011.7 1021.2 1023.8 5148.6 5153.4 5157.0 5157.9 5161.7 6118.7 6142.5 6150.6 6163.3 6166.2 5120.2 5140.3 5141.7 5146.9 5151.2 3219.8 3300.8 3319.0 3333.3 3334.1 5796.6 5851.2 5866.0 5869.9 5885.3 6389.2 6396.6 6409.9 6411.5 6423.5 5684.8 5847.9 5849.8 5855.3 5859.8 6177.6 6180.7 6183.4 6186.4 6203.5 6015.5 6019.8 6058.1 6059.2 6067.7 5716.8 5845.8 5847.8 5849.9 5850.1 4193.5 4269.4 4292.8 4295.5 4304.1 5920.4 6077.8 6096.6 6106.0 6120.1 5729.6 5844.9 5846.2 5860.7 5877.5 5884.3 5904.4 5909.3 5915.3 5917.8 5629.1 5727.0 5749.9 5769.6 5770.9 5953.3 5953.6 5967.5 5968.1 5992.0 5743.5 5767.7 5809.9 5830.6 5837.0 14:02:32 INFO - 2015-12-16 14:02:32,473 DEBUG : BROWSER_OUTPUT: 14:02:32 INFO - 2015-12-16 14:02:32,474 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12164.59 Median:467.04 stddev:13577.12 (2907.1%) stddev-sans-first:13587.86 14:02:32 INFO - 2015-12-16 14:02:32,474 DEBUG : BROWSER_OUTPUT: Values: 688.9 711.3 725.3 740.0 790.6 12310.8 12317.3 12320.1 12329.6 12349.5 11019.7 11135.2 11160.3 11210.6 11224.9 623.4 625.1 789.8 799.9 802.3 801.2 805.2 807.1 807.5 808.6 839.4 854.7 855.0 855.7 856.1 843.1 843.3 846.2 846.6 847.0 624.5 626.7 627.0 627.1 627.6 11000.8 11046.1 11076.9 11130.3 11175.4 10601.8 11109.2 11249.6 11372.4 11403.1 9407.2 9527.0 9550.6 9580.6 9590.7 3129.7 3149.0 3165.3 3304.9 3404.2 37063.3 37089.8 37491.2 37719.4 37807.6 9195.2 9201.6 9262.6 9386.2 9451.4 15887.2 16032.3 16064.6 16689.2 16727.9 6519.5 6542.4 6596.9 6606.9 6725.2 3455.3 3485.3 3487.0 3516.8 3532.6 2539.2 2568.0 2576.5 2598.3 2602.1 462.3 471.8 478.4 479.6 480.9 579.6 592.1 600.6 623.0 631.7 7372.3 7669.9 7740.2 7812.8 7965.8 558.4 595.8 630.9 641.9 648.3 3600.6 3725.3 3859.5 3878.5 3892.2 47242.0 47595.0 47834.5 47849.5 47852.3 44387.8 44871.3 48097.8 48668.5 49186.8 38123.4 38451.6 38540.6 40381.4 40657.8 7732.6 8140.9 8401.8 8500.6 8525.6 31086.5 31822.7 32154.7 32431.7 32656.0 35880.3 37791.0 39950.0 40552.4 40634.0 9981.3 10098.3 10147.9 10186.3 10279.6 11298.9 11387.7 11419.8 11479.4 12128.3 10469.8 10887.6 11056.6 11068.4 11189.9 10582.2 10645.4 10681.5 11099.0 11137.8 9770.9 10720.4 10883.3 11127.1 11147.2 9074.6 9110.1 9233.4 9266.6 9287.4 9144.5 9352.0 9381.3 9521.2 9666.6 14:02:32 INFO - 2015-12-16 14:02:32,474 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:02:32 INFO - 2015-12-16 14:02:32,474 DEBUG : BROWSER_OUTPUT: 14:02:33 INFO - 2015-12-16 14:02:33,193 INFO : Browser exited with error code: 0 14:02:33 INFO - 2015-12-16 14:02:33,210 INFO : Completed test dromaeo_css (00:18:34) 14:02:33 INFO - 2015-12-16 14:02:33,210 INFO : Starting test kraken 14:02:33 INFO - 2015-12-16 14:02:33,210 DEBUG : operating with platform_type : linux_ 14:02:33 INFO - 2015-12-16 14:02:33,210 INFO : Initialising browser for kraken test... 14:02:33 INFO - 2015-12-16 14:02:33,216 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN8HVPC/profile http://localhost:52218/getInfo.html 14:02:37 INFO - 2015-12-16 14:02:37,696 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:02:37 INFO - 2015-12-16 14:02:37,696 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:02:37 INFO - 2015-12-16 14:02:37,696 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:02:37 INFO - 2015-12-16 14:02:37,696 DEBUG : BROWSER_OUTPUT: __metrics 14:02:37 INFO - 2015-12-16 14:02:37,833 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] 14:02:38 INFO - 2015-12-16 14:02:38,785 INFO : Browser initialized. 14:02:38 INFO - 2015-12-16 14:02:38,786 INFO : Running cycle 1/1 for kraken test... 14:02:38 INFO - 2015-12-16 14:02:38,786 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN8HVPC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:02:50 INFO - 2015-12-16 14:02:50,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 143446016 14:02:50 INFO - 2015-12-16 14:02:50,792 DEBUG : BROWSER_OUTPUT: 14:02:53 INFO - 2015-12-16 14:02:53,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52218/tests/kraken/driver.html?testName=audio-beat-detection) 14:02:54 INFO - 2015-12-16 14:02:54,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 143671296 14:02:54 INFO - 2015-12-16 14:02:54,010 DEBUG : BROWSER_OUTPUT: 14:02:56 INFO - 2015-12-16 14:02:56,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52218/tests/kraken/driver.html?testName=audio-dft) 14:02:57 INFO - 2015-12-16 14:02:57,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 142761984 14:02:57 INFO - 2015-12-16 14:02:57,414 DEBUG : BROWSER_OUTPUT: 14:03:00 INFO - 2015-12-16 14:03:00,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52218/tests/kraken/driver.html?testName=audio-fft) 14:03:00 INFO - 2015-12-16 14:03:00,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 139739136 14:03:00 INFO - 2015-12-16 14:03:00,901 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-16 14:03:02,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52218/tests/kraken/driver.html?testName=audio-oscillator) 14:03:03 INFO - 2015-12-16 14:03:03,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 140095488 14:03:03 INFO - 2015-12-16 14:03:03,542 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-16 14:03:05,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:03:06 INFO - 2015-12-16 14:03:06,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 138178560 14:03:06 INFO - 2015-12-16 14:03:06,375 DEBUG : BROWSER_OUTPUT: 14:03:09 INFO - 2015-12-16 14:03:09,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52218/tests/kraken/driver.html?testName=imaging-darkroom) 14:03:10 INFO - 2015-12-16 14:03:10,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 139890688 14:03:10 INFO - 2015-12-16 14:03:10,043 DEBUG : BROWSER_OUTPUT: 14:03:13 INFO - 2015-12-16 14:03:13,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52218/tests/kraken/driver.html?testName=imaging-desaturate) 14:03:14 INFO - 2015-12-16 14:03:14,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 141647872 14:03:14 INFO - 2015-12-16 14:03:14,085 DEBUG : BROWSER_OUTPUT: 14:03:16 INFO - 2015-12-16 14:03:16,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52218/tests/kraken/driver.html?testName=json-parse-financial) 14:03:17 INFO - 2015-12-16 14:03:17,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 141754368 14:03:17 INFO - 2015-12-16 14:03:17,549 DEBUG : BROWSER_OUTPUT: 14:03:19 INFO - 2015-12-16 14:03:19,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:03:19 INFO - 2015-12-16 14:03:19,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 140521472 14:03:19 INFO - 2015-12-16 14:03:19,927 DEBUG : BROWSER_OUTPUT: 14:03:21 INFO - 2015-12-16 14:03:21,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:03:22 INFO - 2015-12-16 14:03:22,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 140308480 14:03:22 INFO - 2015-12-16 14:03:22,416 DEBUG : BROWSER_OUTPUT: 14:03:24 INFO - 2015-12-16 14:03:24,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:03:25 INFO - 2015-12-16 14:03:25,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 140386304 14:03:25 INFO - 2015-12-16 14:03:25,150 DEBUG : BROWSER_OUTPUT: 14:03:27 INFO - 2015-12-16 14:03:27,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:03:28 INFO - 2015-12-16 14:03:28,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 140922880 14:03:28 INFO - 2015-12-16 14:03:28,324 DEBUG : BROWSER_OUTPUT: 14:03:30 INFO - 2015-12-16 14:03:30,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:03:31 INFO - 2015-12-16 14:03:31,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 142397440 14:03:31 INFO - 2015-12-16 14:03:31,579 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52218/tests/kraken/driver.html?testName=ai-astar) 14:03:33 INFO - 2015-12-16 14:03:33,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 141070336 14:03:33 INFO - 2015-12-16 14:03:33,653 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,653 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:03:33 INFO - 2015-12-16 14:03:33,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:03:33 INFO - 2015-12-16 14:03:33,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:03:33 INFO - 2015-12-16 14:03:33,654 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:03:33 INFO - 2015-12-16 14:03:33,654 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;110;117;115;114;128;115;113;116;115 14:03:33 INFO - 2015-12-16 14:03:33,654 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;128;156;169;135;162;163;142;177;132 14:03:33 INFO - 2015-12-16 14:03:33,654 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;162;162;163;163;166;162;161;162 14:03:33 INFO - 2015-12-16 14:03:33,654 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;148;73;73;73;73;157;73 14:03:33 INFO - 2015-12-16 14:03:33,654 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;129;95;95;96;136;94;95;130 14:03:33 INFO - 2015-12-16 14:03:33,654 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;110;109;111;110;111;110;110;110 14:03:33 INFO - 2015-12-16 14:03:33,655 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;147;148;149;148;147;148;147;147 14:03:33 INFO - 2015-12-16 14:03:33,655 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;98;95;96;97;96;96;96;95 14:03:33 INFO - 2015-12-16 14:03:33,655 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;76;74;75;73;73;73;74;80;78;72 14:03:33 INFO - 2015-12-16 14:03:33,655 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;69;68;68;68;68;67;68 14:03:33 INFO - 2015-12-16 14:03:33,655 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;88;87;87;86;85;88;89;86 14:03:33 INFO - 2015-12-16 14:03:33,655 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;138;121;126;125;127;128;122;122;121;132 14:03:33 INFO - 2015-12-16 14:03:33,655 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;154;155;163;166;141;150;144;156;141 14:03:33 INFO - 2015-12-16 14:03:33,656 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;73;71;72;70;71;73;78;70;77 14:03:33 INFO - 2015-12-16 14:03:33,656 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:03:33 INFO - 2015-12-16 14:03:33,656 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:03:33 INFO - 2015-12-16 14:03:33,656 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,779 14:03:33 INFO - 2015-12-16 14:03:33,656 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:03:33 INFO - 2015-12-16 14:03:33,656 DEBUG : BROWSER_OUTPUT: __startTimestamp1450303413648__endTimestamp 14:03:33 INFO - 2015-12-16 14:03:33,656 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:4.69 (4.1%) stddev-sans-first:4.96 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: Values: 115.0 110.0 117.0 115.0 114.0 128.0 115.0 113.0 116.0 115.0 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.60 Median:159.00 stddev:16.71 (10.5%) stddev-sans-first:17.73 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: Values: 152.0 128.0 156.0 169.0 135.0 162.0 163.0 142.0 177.0 132.0 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 162.0 162.0 163.0 163.0 166.0 162.0 161.0 162.0 14:03:33 INFO - 2015-12-16 14:03:33,658 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.60 Median:73.00 stddev:33.75 (46.2%) stddev-sans-first:35.26 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 148.0 73.0 73.0 73.0 73.0 157.0 73.0 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:95.00 stddev:17.88 (18.8%) stddev-sans-first:18.44 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 129.0 95.0 95.0 96.0 136.0 94.0 95.0 130.0 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.71 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 110.0 109.0 111.0 110.0 111.0 110.0 110.0 110.0 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 147.0 148.0 149.0 148.0 147.0 148.0 147.0 147.0 14:03:33 INFO - 2015-12-16 14:03:33,659 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 98.0 95.0 96.0 97.0 96.0 96.0 96.0 95.0 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.80 Median:74.50 stddev:2.53 (3.4%) stddev-sans-first:2.65 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: Values: 76.0 74.0 75.0 73.0 73.0 73.0 74.0 80.0 78.0 72.0 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 69.0 68.0 68.0 68.0 68.0 67.0 68.0 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:87.00 stddev:1.89 (2.2%) stddev-sans-first:1.58 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 88.0 87.0 87.0 86.0 85.0 88.0 89.0 86.0 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:126.50 stddev:5.45 (4.3%) stddev-sans-first:3.76 14:03:33 INFO - 2015-12-16 14:03:33,660 DEBUG : BROWSER_OUTPUT: Values: 138.0 121.0 126.0 125.0 127.0 128.0 122.0 122.0 121.0 132.0 14:03:33 INFO - 2015-12-16 14:03:33,661 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,661 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:154.50 stddev:9.24 (6.0%) stddev-sans-first:9.05 14:03:33 INFO - 2015-12-16 14:03:33,661 DEBUG : BROWSER_OUTPUT: Values: 141.0 154.0 155.0 163.0 166.0 141.0 150.0 144.0 156.0 141.0 14:03:33 INFO - 2015-12-16 14:03:33,661 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-16 14:03:33,661 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:2.74 (3.8%) stddev-sans-first:2.91 14:03:33 INFO - 2015-12-16 14:03:33,661 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 71.0 72.0 70.0 71.0 73.0 78.0 70.0 77.0 14:03:33 INFO - 2015-12-16 14:03:33,661 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:03:33 INFO - 2015-12-16 14:03:33,661 DEBUG : BROWSER_OUTPUT: 14:03:34 INFO - 2015-12-16 14:03:34,630 INFO : Browser exited with error code: 0 14:03:34 INFO - 2015-12-16 14:03:34,679 INFO : Completed test kraken (00:01:01) 14:03:34 INFO - 2015-12-16 14:03:34,679 INFO : Starting test v8_7 14:03:34 INFO - 2015-12-16 14:03:34,679 DEBUG : operating with platform_type : linux_ 14:03:34 INFO - 2015-12-16 14:03:34,679 INFO : Initialising browser for v8_7 test... 14:03:34 INFO - 2015-12-16 14:03:34,685 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQe5qUH/profile http://localhost:52218/getInfo.html 14:03:39 INFO - 2015-12-16 14:03:39,013 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:03:39 INFO - 2015-12-16 14:03:39,013 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:03:39 INFO - 2015-12-16 14:03:39,013 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:03:39 INFO - 2015-12-16 14:03:39,013 DEBUG : BROWSER_OUTPUT: __metrics 14:03:39 INFO - 2015-12-16 14:03:39,162 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] 14:03:40 INFO - 2015-12-16 14:03:40,053 INFO : Browser initialized. 14:03:40 INFO - 2015-12-16 14:03:40,054 INFO : Running cycle 1/1 for v8_7 test... 14:03:40 INFO - 2015-12-16 14:03:40,054 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQe5qUH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:03:52 INFO - 2015-12-16 14:03:52,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 143323136 14:03:52 INFO - 2015-12-16 14:03:52,134 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52218/tests/v8_7/run.html (next: http://localhost:52218/tests/v8_7/run.html) 14:04:13 INFO - 2015-12-16 14:04:13,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 137904128 14:04:13 INFO - 2015-12-16 14:04:13,857 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,858 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:04:13 INFO - 2015-12-16 14:04:13,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:04:13 INFO - 2015-12-16 14:04:13,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:04:13 INFO - 2015-12-16 14:04:13,859 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:04:13 INFO - 2015-12-16 14:04:13,859 DEBUG : BROWSER_OUTPUT: |0;Richards;166.61112962345885 14:04:13 INFO - 2015-12-16 14:04:13,859 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.60758766047135 14:04:13 INFO - 2015-12-16 14:04:13,859 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.31558513588465 14:04:13 INFO - 2015-12-16 14:04:13,859 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 14:04:13 INFO - 2015-12-16 14:04:13,859 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1084.5070422535211 14:04:13 INFO - 2015-12-16 14:04:13,859 DEBUG : BROWSER_OUTPUT: |5;Earley;693.9625260235947 14:04:13 INFO - 2015-12-16 14:04:13,860 DEBUG : BROWSER_OUTPUT: |6;Boyer;12216.867469879518 14:04:13 INFO - 2015-12-16 14:04:13,860 DEBUG : BROWSER_OUTPUT: |7;RegExp;26447.36842105263 14:04:13 INFO - 2015-12-16 14:04:13,860 DEBUG : BROWSER_OUTPUT: |8;Splay;619.5786864931846 14:04:13 INFO - 2015-12-16 14:04:13,860 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:04:13 INFO - 2015-12-16 14:04:13,860 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:04:13 INFO - 2015-12-16 14:04:13,860 DEBUG : BROWSER_OUTPUT: __startTimestamp1450303453857__endTimestamp 14:04:13 INFO - 2015-12-16 14:04:13,860 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,862 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:04:13 INFO - 2015-12-16 14:04:13,862 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:04:13 INFO - 2015-12-16 14:04:13,862 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,862 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.61 Median:166.61 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,863 DEBUG : BROWSER_OUTPUT: Values: 166.6 14:04:13 INFO - 2015-12-16 14:04:13,863 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,863 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.61 Median:191.61 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,863 DEBUG : BROWSER_OUTPUT: Values: 191.6 14:04:13 INFO - 2015-12-16 14:04:13,863 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,863 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.32 Median:277.32 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,863 DEBUG : BROWSER_OUTPUT: Values: 277.3 14:04:13 INFO - 2015-12-16 14:04:13,863 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,864 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,864 DEBUG : BROWSER_OUTPUT: Values: 5191.7 14:04:13 INFO - 2015-12-16 14:04:13,864 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,864 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1084.51 Median:1084.51 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,864 DEBUG : BROWSER_OUTPUT: Values: 1084.5 14:04:13 INFO - 2015-12-16 14:04:13,864 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,864 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:693.96 Median:693.96 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,865 DEBUG : BROWSER_OUTPUT: Values: 694.0 14:04:13 INFO - 2015-12-16 14:04:13,865 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,865 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12216.87 Median:12216.87 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,865 DEBUG : BROWSER_OUTPUT: Values: 12216.9 14:04:13 INFO - 2015-12-16 14:04:13,865 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,865 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26447.37 Median:26447.37 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,865 DEBUG : BROWSER_OUTPUT: Values: 26447.4 14:04:13 INFO - 2015-12-16 14:04:13,866 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,866 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.58 Median:619.58 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,866 DEBUG : BROWSER_OUTPUT: Values: 619.6 14:04:13 INFO - 2015-12-16 14:04:13,866 DEBUG : BROWSER_OUTPUT: 14:04:13 INFO - 2015-12-16 14:04:13,866 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:04:13 INFO - 2015-12-16 14:04:13,866 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:04:13 INFO - 2015-12-16 14:04:13,866 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:04:13 INFO - 2015-12-16 14:04:13,866 DEBUG : BROWSER_OUTPUT: 14:04:14 INFO - 2015-12-16 14:04:14,793 INFO : Browser exited with error code: 0 14:04:14 INFO - 2015-12-16 14:04:14,808 INFO : Completed test v8_7 (00:00:40) 14:04:14 INFO - 2015-12-16 14:04:14,849 INFO : Completed test suite (00:20:15) 14:04:14 INFO - 2015-12-16 14:04:14,849 DEBUG : Working with test: dromaeo_css 14:04:14 INFO - 2015-12-16 14:04:14,849 DEBUG : Generating results file: dromaeo_css 14:04:14 INFO - 2015-12-16 14:04:14,850 DEBUG : Working with test: kraken 14:04:14 INFO - 2015-12-16 14:04:14,850 DEBUG : Generating results file: kraken 14:04:14 INFO - 2015-12-16 14:04:14,851 INFO : javascript benchmark 14:04:14 INFO - 2015-12-16 14:04:14,851 DEBUG : Working with test: v8_7 14:04:14 INFO - 2015-12-16 14:04:14,851 DEBUG : Generating results file: v8_7 14:04:14 INFO - 2015-12-16 14:04:14,851 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:14 INFO - 2015-12-16 14:04:14,904 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 14:04:14 INFO - 2015-12-16 14:04:14,904 DEBUG : process_Request line: dromaeo_css 6244.61 graph.html#tests=[[72,132,43]] 14:04:14 INFO - 2015-12-16 14:04:14,905 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:14 INFO - 2015-12-16 14:04:14,933 DEBUG : process_Request line: kraken 1558.00 graph.html#tests=[[232,132,43]] 14:04:14 INFO - 2015-12-16 14:04:14,933 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:14 INFO - 2015-12-16 14:04:14,962 DEBUG : process_Request line: v8_7 21233.81 graph.html#tests=[[230,132,43]] 14:04:14 INFO - 2015-12-16 14:04:14,964 INFO : javascript benchmark 14:04:15 INFO - 2015-12-16 14:04:14,967 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2678.491086693528, 2724.7139050399696, 2757.669079710435, 2767.142185922364, 2779.8332100074003, 4590.150822097914, 4771.260454629533, 4861.124957629656, 4876.756162191885, 4906.141425250585, 4753.073150735608, 4761.309610106532, 4789.401324834395, 4797.592204662599, 4800.519948005198, 4420.602145806877, 4472.552744725534, 4473.418455600784, 4486.2821948488245, 4513.548645135476, 4486.237339652251, 4516.299973504096, 4540.432445944257, 4540.841070562531, 4579.839705610304, 4286.185624731291, 4370.0, 4446.444194475691, 4485.529019452975, 4539.523350048247, 4426.136903303857, 4454.799534020977, 4460.955390446086, 4464.7321160730135, 4496.7301961882395, 4265.765382903939, 4396.054848207618, 4443.844465443726, 4444.599881090968, 4472.127935052666, 4629.444466663988, 4650.9069818603775, 4650.930236046462, 4658.883527911796, 4720.811167553294, 5053.722045287508, 5164.509371609691, 5169.043726910533, 5174.09453345663, 5186.507281808223, 5179.870503237412, 5185.222216667492, 5186.636935414523, 5191.558717509016, 5196.636235463519, 4636.9536304637195, 4706.388169537938, 4769.2607645814605, 4812.542808433193, 4862.586680132157, 5316.840494785085, 5321.228421878806, 5330.760115794798, 5333.253344531769, 5377.274068000848, 4825.95174048255, 5103.719295438712, 5105.0810854045885, 5115.232715092691, 5128.589712822965, 5064.240363945364, 5106.131957567222, 5129.3075434816565, 5130.127878260705, 5213.348331458567, 5131.2559678846355, 5151.098557752453, 5156.716380599028, 5158.535731784157, 5197.97401013, 4874.46380898101, 5023.623228257895, 5121.155009423478, 5122.692638441706, 5130.51260130287, 4174.08170202555, 4210.831566737357, 4243.151369726067, 4275.636570891447, 4277.315629499265, 3700.0564855961557, 3723.77657340555, 3726.087108658342, 3736.5889752127246, 3772.2266935278203, 4351.891202719894, 4398.142362239332, 4439.134368798053, 4452.398926144993, 4474.418325617714, 5127.769250383742, 5142.87142821425, 5158.613104017214, 5158.942416804546, 5187.066328060985, 4480.708753930984, 4481.305397663367, 4488.0, 4498.167838949805, 4533.274676051816, 4323.308270676739, 4387.100644367897, 4451.0, 4468.21806183923, 4566.06395688883, 4820.71075735457, 4858.05267972742, 4878.317035615017, 4898.118338699069, 4939.0, 5144.6913185209005, 5160.071187186342, 5175.249588809676, 5176.456472070529, 5192.532672059533, 4723.173444647105, 4840.443349014909, 4841.927371089507, 4956.033573453286, 4956.752162391794, 5093.388793344822, 5095.745212739423, 5117.0, 5127.871803204801, 5168.58651307887, 5191.480851914778, 5195.350581177353, 5199.74001299941, 5203.271541984201, 5208.73956302191, 4736.265878788656, 4888.169011268022, 4888.95111048885, 4986.102501549756, 5016.498350164954, 4984.775685094107, 5019.974900125476, 5027.371578552681, 5043.773030213722, 5047.722375269395, 4700.130475861976, 4896.0, 4927.852164435073, 4935.235038569028, 4952.801887924443, 4925.0, 4968.776405061853, 5011.624128190473, 5028.145215313479, 5085.669431486942, 4910.214365701613, 4951.306817045688, 4953.281774142802, 4960.503949605155, 4996.550310472075], "unit": "score", "name": "dojo.html", "value": 4713.59860277117}, {"lowerIsBetter": false, "replicates": [562.9500980671049, 568.3747877334931, 571.8941995730787, 578.1616655849017, 614.1340709599466, 35314.82342588287, 36179.63820361796, 36271.09322266945, 36279.4558081629, 36369.54521819128, 36368.81815590918, 36863.26273474529, 36926.0, 36930.07674808131, 37005.81497092511, 7755.806104847367, 7915.52506849588, 7917.208279172094, 7924.405669574776, 7928.722494712686, 7627.122880868688, 7735.497192682486, 7753.922460775377, 7790.493617914817, 7795.766127016199, 7838.529688218725, 7891.250331218554, 7892.56590887501, 7895.092064412609, 7904.367650587968, 7807.804804879895, 7831.921680783176, 7857.528548287121, 7912.327452166573, 7919.326857217144, 7650.655720492591, 7808.0, 7811.414143939227, 7820.139784623687, 7843.37253019757, 33642.1589460263, 33965.32069358624, 33973.490397644055, 34044.957302561925, 34079.14802129942, 2837.4466978939117, 2979.8063125896747, 3060.908172754821, 3090.90727278182, 3242.789218700777, 27175.45649087027, 27245.86377068122, 27713.030043948365, 27812.0, 28151.155465336073, 3267.738580913521, 3288.2765791525826, 3297.258116923673, 3416.1288871337897, 3454.6199918008997, 201838.0, 202124.0, 202849.0, 203045.0, 203225.0, 50308.49691503038, 51139.0, 52064.739676301375, 52268.73865630647, 52770.20844687333, 53659.0, 53677.463225367246, 53804.730976344865, 53828.730856345464, 53892.461075389525, 14091.577252682437, 14464.493742718954, 14476.493322733864, 14484.34820433083, 14498.85501144975, 9985.750356241153, 10063.245256605784, 10077.0, 10077.596896124072, 10078.697639070839, 17830.0, 18191.45425637233, 18217.271309147487, 18229.7265541017, 18287.81712182861, 7666.425018123663, 7923.286904178652, 7981.241782030698, 8025.2777250047775, 8033.277005069572, 872.6334939325499, 873.7728190670472, 897.9191872731485, 966.1932286540817, 1007.6725064354114, 24904.875475622506, 25517.87241063783, 25690.871545642527, 25693.229203123938, 25912.352191195372, 939.1359948847077, 977.3647129365827, 1024.283001898659, 1063.7606538528769, 1124.4714983957526, 13281.667958300926, 13436.925045996297, 13562.93218533901, 13586.93206533961, 13632.386542605607, 257808.0, 260606.0, 261126.0, 261890.0, 263660.0, 44459.11081778411, 44537.33194002092, 44566.77716611461, 45039.0, 45103.32345014827, 1222.4010234984794, 1233.2785320587557, 1234.4383305595932, 1248.7752204603078, 1252.1422825364655, 25079.373015674755, 25443.61834572446, 25559.10543131056, 25625.615615765404, 25711.0, 39679.60320396759, 39996.40005399863, 40112.799436002635, 40141.79929100453, 40152.598474014885, 244928.0, 245986.0, 246157.0, 248736.0, 250005.0, 28560.285992850346, 29082.41835163327, 29129.417411651226, 29139.0, 29162.854185728935, 33532.49701254434, 33539.83230083834, 33910.15224619404, 34297.0, 34316.31367372689, 28893.855530722212, 28977.42045159127, 29452.0, 29516.262093447836, 29718.851405742833, 30991.69008309888, 31593.5260971081, 31826.681733182373, 32128.19679508031, 32362.676373235965, 32943.176420588716, 32999.67000330062, 33264.0, 33507.0, 33898.152546186546, 26798.0, 27739.72260277452, 29665.25836854096, 30036.849815750782, 30101.849490752407, 22688.546229075655, 22925.88537057304, 23035.424114396603, 23166.0, 23277.883610581837], "unit": "score", "name": "ext.html", "value": 16458.767800499063}, {"lowerIsBetter": false, "replicates": [341.5730337078652, 341.812003398131, 341.81883601691095, 342.3888359278688, 342.73438085483747, 14845.331960061796, 15095.849041509595, 15921.442749503754, 16003.679926401464, 16717.0, 9963.15313198379, 10213.897861021387, 14249.572512824607, 15856.0, 15869.841301586981, 4417.1607394595, 4514.593686568208, 4717.433907931053, 5125.564327032188, 5133.691978481284, 5110.693358398489, 5134.691918484884, 5135.614828887829, 5136.794528218886, 5153.871153221162, 3443.0, 4928.162212423897, 5101.362329708786, 5105.081085404626, 5192.454792246816, 5044.344235249431, 5074.847754567369, 5083.567896728782, 5089.160288552384, 5154.974225128869, 4947.307376967227, 4974.10466116099, 4986.800527978877, 5081.822136225252, 5086.898262034739, 11260.324380537111, 11497.770044599061, 13546.983976201824, 19183.0, 19344.32294869687, 1796.694561924463, 1825.9087045647798, 1828.3692126216433, 1910.0545230111184, 1957.862949593529, 8895.0, 9114.77213069672, 11187.944060279728, 12850.742985140338, 12968.740625187538, 1720.7246840505459, 1722.9834397705415, 1733.306677329066, 1808.21342715919, 1837.3752924005903, 52838.0, 54235.457645423434, 54881.45118548803, 57453.13820292699, 57974.71012644952, 9793.87370452407, 9943.154831839374, 9986.800263994824, 10053.296269261227, 10064.748381290527, 12608.0, 12687.619371418872, 12694.238345699288, 12707.237565746085, 12747.872521274669, 7164.0, 7170.067891174114, 7193.568385896863, 7264.745733899288, 7339.266073392725, 6810.489213309022, 6822.11312529368, 6834.384905358542, 6834.931650683529, 6850.725970961105, 4277.165952639268, 4282.850100246476, 4286.5070516890955, 4307.375430562551, 4317.201317756225, 1617.2398972482915, 1657.4033347994712, 1663.0853030832993, 1698.230595027753, 1720.91395430228, 363.7144841299567, 366.76893557058884, 406.73968660057585, 836.188896770132, 852.8123812761182, 8999.37004409698, 9000.63997440095, 9561.760955976017, 9598.232141428669, 9794.853077203848, 392.54464820807726, 404.19968462444524, 406.2991339938582, 406.7031067320813, 414.73456987528004, 5312.946870531323, 5368.892622147613, 5369.114096174166, 5371.75827087782, 5382.192671099367, 449809.0, 460304.0, 465595.0, 466917.0, 471246.0, 67215.3278467209, 68861.65569172222, 69007.65496172487, 69380.0, 69404.30595693979, 444.54434204940196, 447.0678635045966, 447.6172872194292, 447.7604481602327, 448.85636596288873, 8703.43427677199, 8874.423162494417, 8935.463872167691, 8968.506732129796, 9016.594253258489, 28956.710432896245, 29033.564496532148, 29229.0, 29448.852755736083, 30284.69715302907, 43557.78221109001, 44536.109277813615, 44922.550774491836, 45079.32381014222, 45534.772326138154, 8763.649454021768, 8957.193852553302, 9003.594838232426, 9011.279097672039, 9013.729588112366, 10121.443320617436, 15671.843281567495, 15901.761473577673, 16411.91794041022, 16454.670906581563, 13189.868101318863, 13332.800007999695, 13587.52443664467, 13714.725705486035, 13832.515861944783, 12683.556075537312, 13062.738745225231, 13185.736285274432, 13636.181829090287, 13711.862881371457, 13902.443902243796, 14641.853581464475, 14650.267486625413, 14725.116493010453, 14834.554963351116, 8454.323654107533, 8567.314614830922, 8898.42160259581, 9192.632294708405, 9194.632214711337, 9429.858552121861, 10724.678259652223, 14009.229492378017, 14234.786478202628, 14290.857091428952], "unit": "score", "name": "jquery.html", "value": 7417.860974485445}, {"lowerIsBetter": false, "replicates": [1489.3223583269614, 1695.5083025922484, 1740.5909611241364, 1765.6292178642489, 1768.3899054826088, 6096.390360963901, 6242.531810114248, 7002.369786719194, 7414.369778568828, 7452.888206676904, 6751.966240168805, 6923.446124310056, 6993.195782485016, 6997.1253593300835, 7021.68402421891, 2089.4880754215237, 2127.9468013299715, 2130.0947097483586, 2131.4458240857334, 2132.8720276783365, 2052.4253209101403, 2060.7115003899467, 2067.03882694547, 2070.6272870883236, 2076.636588596997, 2032.2277534536856, 2033.0, 2034.9898250508727, 2046.9867415629285, 2055.1779288284656, 2073.78225286345, 2091.613051585454, 2094.5077906691913, 2098.6642137257963, 2098.8425868059803, 2075.2217918280644, 2082.7188329575465, 2111.883846388448, 2115.23851413491, 2129.1057755742627, 7189.8202544936275, 7257.854842903165, 7266.672999715025, 7274.054372931485, 7280.927190728078, 4199.91600167995, 4213.494380674308, 4220.78896055196, 4222.535521092708, 4243.299855523835, 2725.8773355198864, 2736.822106563067, 2780.124260857823, 2850.3016760893506, 2852.386736851566, 888.311558542135, 1740.712782390904, 1750.9212085456186, 1760.287083731091, 1775.2189036823886, 9507.429554226768, 9604.471754053524, 9633.421994680342, 9633.759156021086, 9654.806903861954, 3782.6973842092566, 3820.312343778091, 3832.137769001952, 3878.3019056569524, 3915.0212446888277, 7698.422618303538, 7726.072871255486, 7742.729004484816, 7751.302382785577, 7760.805979850549, 4180.519240287345, 4216.47294088239, 4225.619694227535, 4226.344916537942, 4228.1966426378885, 3823.25446537928, 3892.6885849132, 3914.2171565686976, 3928.2929072766606, 3932.0, 3280.097973057428, 3304.5869266341706, 3304.669533046724, 3325.384803811254, 3348.3135957129216, 957.3585697582637, 957.8467445208734, 968.9854652180223, 974.6150270643057, 981.6711401680517, 1087.380193289833, 1105.209775010871, 1106.336198281041, 1234.216272666863, 1234.6481252842896, 6691.230508491586, 6812.284710105467, 6815.079964204868, 6838.760643377458, 6840.555363901331, 398.92420440116285, 399.9400089986525, 400.31945692322586, 400.6754528831656, 407.2404964740737, 5456.236126942231, 5469.808556700496, 5495.560355171577, 5509.311336082989, 5520.199571062254, 8632.223099920911, 8700.738977830675, 8814.162654547808, 8863.955680221687, 8880.8667869982, 8716.215540601377, 8717.0, 8719.04090550039, 8720.520371379509, 8743.562821859008, 6591.176102987127, 6735.191776986793, 6819.795406137824, 6894.448444124458, 6903.930960690429, 6768.0, 6806.319368063154, 6827.04421381017, 6836.794896153124, 6837.589744615339, 7644.80887977805, 7651.693932242648, 7840.647170877438, 7902.920970790218, 7913.564753938358, 7777.3778097753175, 7952.165022672536, 7986.081600615771, 8007.959960200162, 8012.679492820222, 5281.181416880389, 5434.701091440009, 6290.905636415366, 6333.429991300805, 6341.334159913143, 6708.83227919306, 6709.832254193684, 6747.055412242388, 6755.392014718699, 6760.93239067603, 6123.295820980644, 6295.779647712308, 6350.523710721622, 6489.480841532761, 6544.509161812978, 6122.081687746873, 6180.938190618216, 6210.813675589739, 6285.685715714288, 6304.779332723333, 6341.112244285896, 6371.203599550056, 6390.968045159744, 6427.421532062137, 6430.807075787734, 5885.028970219866, 5986.281646202484, 5987.371326010706, 6011.489023432882, 6019.18740969981, 5983.282006159288, 6035.456808887221, 6056.7274472649715, 6058.151858739692, 6066.939330606638], "unit": "score", "name": "mootools.html", "value": 4071.538017952954}, {"lowerIsBetter": false, "replicates": [305.4623862002875, 309.11438728044146, 313.84151003743114, 314.4873160099918, 315.75686721224645, 5587.552995760335, 5660.716964151787, 5678.460546248105, 5691.857703557408, 5695.0, 5548.944510554893, 5551.528120109796, 5575.163725441186, 5585.636933599313, 5596.692181929992, 4177.0, 4256.574342565734, 4284.550122237167, 4296.226679197735, 4328.177646247219, 4215.135897141079, 4240.363945408182, 4261.744295342274, 4276.957230427703, 4281.785910704468, 4203.453551038361, 4212.8314867405425, 4224.683148763855, 4225.112726327475, 4232.915341693164, 4209.831606735727, 4215.156968606291, 4225.535191128974, 4260.08408192237, 4265.402843601898, 3650.4524321351746, 3689.7786132832116, 3702.426123950792, 3722.5346831646043, 3726.329260733067, 5277.656952298088, 5422.0, 5422.783088676449, 5428.538574221196, 5444.646098003617, 4915.3855768029, 4918.926216106761, 4919.016196760662, 4922.064807686528, 4924.630652701062, 5916.615419997729, 5923.911141332884, 5927.822165335004, 5933.821985340447, 5936.7328470218945, 3912.628300311466, 4027.3958906164016, 4036.777977211252, 4056.4726585543985, 4057.918841623151, 6178.351273116348, 6197.0704394340755, 6232.657203853786, 6236.126942228092, 6238.719257633372, 4115.444415003996, 4132.979335103305, 4148.43996060534, 4152.27335216342, 4166.500019997619, 4196.202721482909, 4202.159568086395, 4213.136307057046, 4214.325707886724, 4218.49378074633, 4707.905841883143, 4719.480857105716, 4870.391201099863, 4875.195592727231, 4882.658213925062, 5899.46904778572, 5906.114082887601, 5911.467967882825, 5913.231279933667, 5934.8813023739285, 1454.8545145485366, 1499.9050692994176, 1501.0918394371467, 1502.6919481506266, 1505.789189513469, 994.6021591363512, 1003.5985605757755, 1011.6914341126027, 1021.2289721260549, 1023.8413045977885, 5148.562372198405, 5153.3558305211845, 5157.0, 5157.948420515821, 5161.66449180802, 6118.663473508911, 6142.539309551801, 6150.630962142286, 6163.260408750979, 6166.229221347332, 5120.231965205175, 5140.254663073833, 5141.665791723526, 5146.8970620588125, 5151.201563757623, 3219.806811591312, 3300.801951882847, 3319.0, 3333.283344081034, 3334.0997930558615, 5796.565257605696, 5851.239338885917, 5865.970670146622, 5869.853253668607, 5885.264341957255, 6389.201349831271, 6396.552241343062, 6409.935900640934, 6411.487081033506, 6423.518236132309, 5684.8294551163535, 5847.853803654943, 5849.795257165979, 5855.268091488564, 5859.794907178229, 6177.567570270038, 6180.6909654517995, 6183.443490085914, 6186.412290832363, 6203.534734894811, 6015.518758499397, 6019.819405417845, 6058.0912863069125, 6059.151718759289, 6067.666278354733, 5716.828495145152, 5845.766169353178, 5847.8245652630485, 5849.94150058494, 5850.0932355484965, 4193.517745459311, 4269.423627810206, 4292.806823692878, 4295.506016807982, 4304.127704448575, 5920.37836027211, 6077.787277445268, 6096.634201947897, 6105.9694701526205, 6120.051392034242, 5729.598928074995, 5844.912326315024, 5846.152307915413, 5860.677662728591, 5877.471027607536, 5884.32330282023, 5904.409559044061, 5909.261342332208, 5915.260592425947, 5917.792877249276, 5629.08611072221, 5726.997775389374, 5749.8562535936935, 5769.624974376652, 5770.855728606651, 5953.345132035559, 5953.553483488669, 5967.522598192048, 5968.104784282393, 5991.981363168359, 5743.483086522233, 5767.711614419346, 5809.9419005809405, 5830.5627077968475, 5836.970815145897], "unit": "score", "name": "prototype.html", "value": 4409.386814137544}, {"lowerIsBetter": false, "replicates": [688.8725585766632, 711.3100292716067, 725.2783480436963, 739.9936086921786, 790.6165509727784, 12310.753784924296, 12317.322547259897, 12320.075994300418, 12329.568465103723, 12349.506019759221, 11019.669409917695, 11135.220534562584, 11160.274582152155, 11210.607628732996, 11224.943875280613, 623.4295619508144, 625.1373105114935, 789.838083192944, 799.8640231160688, 802.2859654907137, 801.2428255298715, 805.1827395193883, 807.1484583764127, 807.5154907055748, 808.5633757770797, 839.3704721458906, 854.7264875239925, 855.0338117926734, 855.670566831768, 856.0839901305606, 843.1399972028557, 843.2705709561246, 846.2468403121227, 846.6147902704286, 847.0, 624.5409623926456, 626.7273735924841, 627.0374974414298, 627.1032423634201, 627.5920651576466, 11000.834987475195, 11046.116310695206, 11076.889231107747, 11130.276532025473, 11175.441227938652, 10601.78796424075, 11109.222354435193, 11249.60626378081, 11372.37451940143, 11403.144764142722, 9407.153356197907, 9526.9523652382, 9550.61797528098, 9580.616775329048, 9590.6643267486, 3129.687031296875, 3149.0395429394025, 3165.319456316903, 3304.867805287786, 3404.1659793350786, 37063.258734825155, 37089.814550927615, 37491.167835995475, 37719.43420848689, 37807.62192378069, 9195.172434480928, 9201.585928633227, 9262.629494820132, 9386.155246027754, 9451.432914025181, 15887.205639717968, 16032.278547465392, 16064.598385040468, 16689.165541722865, 16727.91636041812, 6519.511036672268, 6542.443892269115, 6596.868062638816, 6606.86786264272, 6725.19297684281, 3455.326211388755, 3485.3224790904956, 3487.0, 3516.82415879205, 3532.6290739472497, 2539.21284401836, 2567.9743202567734, 2576.4975829713026, 2598.3244356467453, 2602.0632572273967, 462.30192409461955, 471.78062201076665, 478.4497827498405, 479.5516192360154, 480.86776136562025, 579.6174524813687, 592.1295695327861, 600.5795942839942, 622.9689863276285, 631.6904716688789, 7372.336489715844, 7669.923300766921, 7740.225977402215, 7812.84374312522, 7965.761027169194, 558.4359796605377, 595.8004068637055, 630.9305976342598, 641.9197600299963, 648.3192647719875, 3600.58593261773, 3725.273571653556, 3859.4789703390243, 3878.5151856017997, 3892.2215556888737, 47242.0, 47595.0, 47834.521654783006, 47849.5215047852, 47852.28221576679, 44387.77806111013, 44871.326930096075, 48097.75951120222, 48668.51331486711, 49186.75406622944, 38123.42814857779, 38451.57806852192, 38540.6145938537, 40381.394279085835, 40657.79671101626, 7732.613369331399, 8140.877886831584, 8401.789955251168, 8500.617472213642, 8525.573721314033, 31086.53370199494, 31822.6817731829, 32154.67845321517, 32431.675683242865, 32656.0, 35880.282394351445, 37791.0, 39950.0, 40552.391714123725, 40634.0, 9981.251406144424, 10098.293119481566, 10147.898521014991, 10186.337888037255, 10279.588816447558, 11298.943505282421, 11387.715307117389, 11419.771604568028, 11479.36863472517, 12128.332941688292, 10469.790604188025, 10887.618933337295, 11056.613018544313, 11068.391238481961, 11189.944050280023, 10582.153427725918, 10645.361278323326, 10681.51933162994, 11099.0, 11137.777244455228, 9770.853437198306, 10720.410377429316, 10883.292585981886, 11127.109831213646, 11147.219694621299, 9074.637014519609, 9110.10919548831, 9233.353665243369, 9266.629334826801, 9287.396319239228, 9144.542772861198, 9351.953240233755, 9381.343305968516, 9521.19069879068, 9666.565004574952], "unit": "score", "name": "yui.html", "value": 5738.84424055083}], "name": "dromaeo_css", "value": 6244.606226027091}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 117.0, 115.0, 114.0, 128.0, 115.0, 113.0, 116.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.8}, {"lowerIsBetter": true, "replicates": [152.0, 128.0, 156.0, 169.0, 135.0, 162.0, 163.0, 142.0, 177.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 162.0, 163.0, 163.0, 166.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 148.0, 73.0, 73.0, 73.0, 73.0, 157.0, 73.0], "unit": "score", "name": "audio-fft", "value": 88.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 129.0, 95.0, 95.0, 96.0, 136.0, 94.0, 95.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 109.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 75.0, 73.0, 73.0, 73.0, 74.0, 80.0, 78.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 74.8}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 88.0, 87.0, 87.0, 86.0, 85.0, 88.0, 89.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [138.0, 121.0, 126.0, 125.0, 127.0, 128.0, 122.0, 122.0, 121.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [141.0, 154.0, 155.0, 163.0, 166.0, 141.0, 150.0, 144.0, 156.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 72.0, 70.0, 71.0, 73.0, 78.0, 70.0, 77.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.8}], "name": "kraken", "value": 1557.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.61112962345885], "unit": "score", "name": "Richards", "value": 211.88260400000004}, {"lowerIsBetter": false, "replicates": [191.60758766047135], "unit": "score", "name": "DeltaBlue", "value": 345.06984200000005}, {"lowerIsBetter": false, "replicates": [277.31558513588465], "unit": "score", "name": "Encrypt", "value": 959.8486860000002}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1084.5070422535211], "unit": "score", "name": "RayTrace", "value": 682.3275194805196}, {"lowerIsBetter": false, "replicates": [693.9625260235947], "unit": "score", "name": "Earley", "value": 960.373183}, {"lowerIsBetter": false, "replicates": [12216.867469879518], "unit": "score", "name": "Boyer", "value": 54.55269132149902}, {"lowerIsBetter": false, "replicates": [26447.36842105263], "unit": "score", "name": "RegExp", "value": 34.44520398009948}, {"lowerIsBetter": false, "replicates": [619.5786864931846], "unit": "score", "name": "Splay", "value": 131.52647400000006}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21233.80831415909}]} 14:04:15 INFO - RETURN: dromaeo_css: 6244.61 14:04:15 INFO - RETURN: kraken: 1558.00 14:04:15 INFO - RETURN: v8_7: 21233.81 14:04:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21233.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1558.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6244.61"}}} 14:04:15 INFO - Return code: 0 14:04:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:04:15 INFO - # TBPL SUCCESS # 14:04:15 INFO - Running post-action listener: _resource_record_post_action 14:04:15 INFO - Running post-run listener: _resource_record_post_run 14:04:16 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 585728; Write bytes: 287277056; Read time: 84; Write time: 168468 14:04:16 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 14233600; Read time: 0; Write time: 2712 14:04:16 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 585728; Write bytes: 273043456; Read time: 84; Write time: 165756 14:04:16 INFO - Running post-run listener: _upload_blobber_files 14:04:16 INFO - Blob upload gear active. 14:04:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:04:16 INFO - Copying logs to upload dir... 14:04:16 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.706590 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-16 14:04:16.075320) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 14:04:16.080808) ========= 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=b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010118 build_url: 'https://queue.taskcluster.net/v1/task/kub_x9m4RjqATGnTQmu8Qg/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-16 14:04:16.131769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 14:04:16.132100) ========= 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=b00de3c228505fac2445e70d000001bb-1450294029.77377-1755546985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 14:04:16.181158) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 14:04:16.181468) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 14:04:16.181744) ========= ========= Total master_lag: 0.27 =========