builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1452537629.82 results: success (0) buildid: 20160111100228 builduid: 44675aa8d249455cad53c9445bafc32e revision: 436e2013c50f184a17144ee878e736b2607fef96 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:29.825344) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:29.825749) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:29.826029) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006327 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:29.876275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:29.876760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:29.948042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:29.948293) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.014949) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.015278) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.015695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.015967) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 10:40:30-- 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% 214M=0s 2016-01-11 10:40:30 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161520 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.194355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.194665) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017140 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.244373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.244732) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 436e2013c50f184a17144ee878e736b2607fef96 --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 436e2013c50f184a17144ee878e736b2607fef96 --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=fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 10:40:30,446 truncating revision to first 12 chars 2016-01-11 10:40:30,446 Setting DEBUG logging. 2016-01-11 10:40:30,446 attempt 1/10 2016-01-11 10:40:30,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/436e2013c50f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 10:40:30,710 unpacking tar archive at: fx-team-436e2013c50f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.808987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.809329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.822830) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.823178) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 10:40:30.823662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-11 10:40:30.823983) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:40:31 INFO - MultiFileLogger online at 20160111 10:40:31 in /builds/slave/test 10:40:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:40:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:40:31 INFO - {'append_to_log': False, 10:40:31 INFO - 'base_work_dir': '/builds/slave/test', 10:40:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:40:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:40:31 INFO - 'branch': 'Fx-Team-Non-PGO', 10:40:31 INFO - 'buildbot_json_path': 'buildprops.json', 10:40:31 INFO - 'config_files': ('talos/linux_config.py',), 10:40:31 INFO - 'default_actions': ('clobber', 10:40:31 INFO - 'read-buildbot-config', 10:40:31 INFO - 'download-and-extract', 10:40:31 INFO - 'populate-webroot', 10:40:31 INFO - 'create-virtualenv', 10:40:31 INFO - 'install', 10:40:31 INFO - 'run-tests'), 10:40:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:40:31 INFO - 'download_minidump_stackwalk': True, 10:40:31 INFO - 'download_symbols': 'ondemand', 10:40:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:40:31 INFO - 'tooltool.py': '/tools/tooltool.py', 10:40:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:40:31 INFO - '/tools/misc-python/virtualenv.py')}, 10:40:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:40:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:40:31 INFO - 'installer_path': 'installer.exe', 10:40:31 INFO - 'log_level': 'info', 10:40:31 INFO - 'log_name': 'talos', 10:40:31 INFO - 'log_to_console': True, 10:40:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:40:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:40:31 INFO - 'opt_config_files': (), 10:40:31 INFO - 'pip_index': False, 10:40:31 INFO - 'sps_profile': False, 10:40:31 INFO - 'sps_profile_interval': 0, 10:40:31 INFO - 'suite': 'dromaeojs', 10:40:31 INFO - 'system_bits': '32', 10:40:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:40:31 INFO - 'title': 'talos-linux64-ix-014', 10:40:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:40:31 INFO - 'use_talos_json': True, 10:40:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:40:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:40:31 INFO - 'work_dir': 'build'} 10:40:31 INFO - ##### 10:40:31 INFO - ##### Running clobber step. 10:40:31 INFO - ##### 10:40:31 INFO - Running pre-action listener: _resource_record_pre_action 10:40:31 INFO - Running main action method: clobber 10:40:31 INFO - rmtree: /builds/slave/test/build 10:40:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:40:31 INFO - Running post-action listener: _resource_record_post_action 10:40:31 INFO - ##### 10:40:31 INFO - ##### Running read-buildbot-config step. 10:40:31 INFO - ##### 10:40:31 INFO - Running pre-action listener: _resource_record_pre_action 10:40:31 INFO - Running main action method: read_buildbot_config 10:40:31 INFO - Using buildbot properties: 10:40:31 INFO - { 10:40:31 INFO - "project": "", 10:40:31 INFO - "product": "firefox", 10:40:31 INFO - "script_repo_revision": "production", 10:40:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:40:31 INFO - "repository": "", 10:40:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:40:31 INFO - "buildid": "20160111100228", 10:40:31 INFO - "pgo_build": "False", 10:40:31 INFO - "basedir": "/builds/slave/test", 10:40:31 INFO - "buildnumber": 1117, 10:40:31 INFO - "slavename": "talos-linux64-ix-014", 10:40:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:40:31 INFO - "platform": "ubuntu64_hw", 10:40:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:40:31 INFO - "branch": "fx-team", 10:40:31 INFO - "repo_path": "integration/fx-team", 10:40:31 INFO - "revision": "436e2013c50f184a17144ee878e736b2607fef96", 10:40:31 INFO - "stage_platform": "linux64", 10:40:31 INFO - "builduid": "44675aa8d249455cad53c9445bafc32e", 10:40:31 INFO - "slavebuilddir": "test" 10:40:31 INFO - } 10:40:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:40:31 INFO - Running post-action listener: _resource_record_post_action 10:40:31 INFO - ##### 10:40:31 INFO - ##### Running download-and-extract step. 10:40:31 INFO - ##### 10:40:31 INFO - Running pre-action listener: _resource_record_pre_action 10:40:31 INFO - Running main action method: download_and_extract 10:40:31 INFO - mkdir: /builds/slave/test/build/tests 10:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:31 INFO - https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:40:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/test_packages.json 10:40:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/test_packages.json 10:40:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:40:40 INFO - Downloaded 1302 bytes. 10:40:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:40:40 INFO - Using the following test package requirements: 10:40:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:40:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:40:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:40 INFO - u'jsshell-linux-x86_64.zip'], 10:40:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:40:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:40:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:40:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:40:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:40:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:40:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:40:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:40: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')]} 10:40:40 INFO - https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:40:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:40:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:40:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/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 10:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/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 10:40:44 INFO - Downloaded 22756958 bytes. 10:40:44 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 10:40:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:40:44 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 10:40:45 INFO - Return code: 0 10:40:45 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 10:40:45 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')]} 10:40:45 INFO - https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:40:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:40:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:40:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/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 10:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/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 10:40:49 INFO - Downloaded 22756958 bytes. 10:40:49 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 10:40:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:40:49 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 10:40:51 INFO - Return code: 0 10:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:51 INFO - https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:40:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:40:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:40:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/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 10:40:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/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 10:40:53 INFO - Downloaded 11132285 bytes. 10:40:53 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 10:40:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:40:53 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 10:40:53 INFO - Return code: 0 10:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:53 INFO - https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:40:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:40:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:40:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/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 10:40:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/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 10:40:57 INFO - Downloaded 53750349 bytes. 10:40:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:40:57 INFO - mkdir: /builds/slave/test/properties 10:40:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:40:57 INFO - Writing to file /builds/slave/test/properties/build_url 10:40:57 INFO - Contents: 10:40:57 INFO - build_url:https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:40:57 INFO - Running post-action listener: _resource_record_post_action 10:40:57 INFO - Running post-action listener: set_extra_try_arguments 10:40:57 INFO - ##### 10:40:57 INFO - ##### Running populate-webroot step. 10:40:57 INFO - ##### 10:40:57 INFO - Running pre-action listener: _resource_record_pre_action 10:40:57 INFO - Running main action method: populate_webroot 10:40:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:40:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:40:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:40:57 INFO - '--tppagecycles', 10:40:57 INFO - '7'], 10:40:57 INFO - 'tests': ['tsvgm']}}, 10:40:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:40:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:40:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:40:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:40:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:40:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:40:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:57 INFO - 'talos_options': ['--e10s'], 10:40:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:57 INFO - 'tests': ['damp', 'tps']}, 10:40:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:57 INFO - 'talos_options': ['--e10s'], 10:40:57 INFO - 'tests': ['damp', 'tps']}, 10:40:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:40:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:40:57 INFO - 'other': {'tests': ['a11yr', 10:40:57 INFO - 'ts_paint', 10:40:57 INFO - 'tpaint', 10:40:57 INFO - 'sessionrestore', 10:40:57 INFO - 'sessionrestore_no_auto_restore']}, 10:40:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:40:57 INFO - 'tests': ['a11yr', 10:40:57 INFO - 'ts_paint', 10:40:57 INFO - 'tpaint', 10:40:57 INFO - 'sessionrestore', 10:40:57 INFO - 'sessionrestore_no_auto_restore']}, 10:40:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:40:57 INFO - 'tests': ['a11yr', 10:40:57 INFO - 'ts_paint', 10:40:57 INFO - 'tpaint', 10:40:57 INFO - 'sessionrestore', 10:40:57 INFO - 'sessionrestore_no_auto_restore']}, 10:40:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:40:57 INFO - 'tests': ['a11yr', 10:40:57 INFO - 'ts_paint', 10:40:57 INFO - 'tpaint', 10:40:57 INFO - 'sessionrestore', 10:40:57 INFO - 'sessionrestore_no_auto_restore']}, 10:40:57 INFO - 'other_l64': {'tests': ['a11yr', 10:40:57 INFO - 'ts_paint', 10:40:57 INFO - 'tpaint', 10:40:57 INFO - 'sessionrestore', 10:40:57 INFO - 'sessionrestore_no_auto_restore']}, 10:40:57 INFO - 'other_nol64': {'tests': ['a11yr', 10:40:57 INFO - 'ts_paint', 10:40:57 INFO - 'tpaint', 10:40:57 INFO - 'sessionrestore', 10:40:57 INFO - 'sessionrestore_no_auto_restore']}, 10:40:57 INFO - 'svgr': {'tests': ['tsvgx', 10:40:57 INFO - 'tsvgr_opacity', 10:40:57 INFO - 'tart', 10:40:57 INFO - 'tscrollx', 10:40:57 INFO - 'cart']}, 10:40:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:40:57 INFO - 'tests': ['tsvgx', 10:40:57 INFO - 'tsvgr_opacity', 10:40:57 INFO - 'tart', 10:40:57 INFO - 'tscrollx', 10:40:57 INFO - 'cart']}, 10:40:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:57 INFO - 'tests': ['tp5o']}, 10:40:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:57 INFO - 'talos_options': ['--e10s'], 10:40:57 INFO - 'tests': ['tp5o']}, 10:40:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:57 INFO - 'talos_options': ['--xperf_path', 10:40:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:57 INFO - 'tests': ['tp5n']}, 10:40:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:57 INFO - 'talos_options': ['--e10s', 10:40:57 INFO - '--xperf_path', 10:40:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:57 INFO - 'tests': ['tp5n']}}, 10:40:57 INFO - 'talos.zip': {'path': '', 10:40:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:40:57 INFO - Running post-action listener: _resource_record_post_action 10:40:57 INFO - ##### 10:40:57 INFO - ##### Running create-virtualenv step. 10:40:57 INFO - ##### 10:40:57 INFO - Running pre-action listener: _resource_record_pre_action 10:40:57 INFO - Running main action method: create_virtualenv 10:40:57 INFO - Creating virtualenv /builds/slave/test/build/venv 10:40:57 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 10:40:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:40:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:40:57 INFO - Using real prefix '/usr' 10:40:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:40:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:40:59 INFO - Installing pip.................done. 10:40:59 INFO - Return code: 0 10:40:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:59 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 0x7fa8a2303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', '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 10:40:59 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 10:40:59 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 10:40:59 INFO - Using env: {'DISPLAY': ':0', 10:40:59 INFO - 'HOME': '/home/cltbld', 10:40:59 INFO - 'LANG': 'en_US.UTF-8', 10:40:59 INFO - 'LANGUAGE': 'en_US:en', 10:40:59 INFO - 'LOGNAME': 'cltbld', 10:40:59 INFO - 'MAIL': '/var/mail/cltbld', 10:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:59 INFO - 'MOZ_NO_REMOTE': '1', 10:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:59 INFO - 'NO_EM_RESTART': '1', 10:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:59 INFO - 'PWD': '/builds/slave/test', 10:40:59 INFO - 'SHELL': '/bin/bash', 10:40:59 INFO - 'SHLVL': '1', 10:40:59 INFO - 'TERM': 'linux', 10:40:59 INFO - 'TMOUT': '86400', 10:40:59 INFO - 'USER': 'cltbld', 10:40:59 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:59 INFO - '_': '/tools/buildbot/bin/python'} 10:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:00 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 10:41:00 INFO - Cleaning up... 10:41:00 INFO - Return code: 0 10:41:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:41:00 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')]} 10:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:00 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')]} 10:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:00 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 0x7fa8a2303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', '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 10:41:00 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 10:41:00 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 10:41:00 INFO - Using env: {'DISPLAY': ':0', 10:41:00 INFO - 'HOME': '/home/cltbld', 10:41:00 INFO - 'LANG': 'en_US.UTF-8', 10:41:00 INFO - 'LANGUAGE': 'en_US:en', 10:41:00 INFO - 'LOGNAME': 'cltbld', 10:41:00 INFO - 'MAIL': '/var/mail/cltbld', 10:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:00 INFO - 'MOZ_NO_REMOTE': '1', 10:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:00 INFO - 'NO_EM_RESTART': '1', 10:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:00 INFO - 'PWD': '/builds/slave/test', 10:41:00 INFO - 'SHELL': '/bin/bash', 10:41:00 INFO - 'SHLVL': '1', 10:41:00 INFO - 'TERM': 'linux', 10:41:00 INFO - 'TMOUT': '86400', 10:41:00 INFO - 'USER': 'cltbld', 10:41:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:00 INFO - '_': '/tools/buildbot/bin/python'} 10:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:00 INFO - Downloading/unpacking psutil>=0.7.1 10:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:41:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:41:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:41:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:41:02 INFO - Installing collected packages: psutil 10:41:02 INFO - Running setup.py install for psutil 10:41:02 INFO - building 'psutil._psutil_linux' extension 10:41:02 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 10:41:02 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 10:41:02 INFO - building 'psutil._psutil_posix' extension 10:41:02 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 10:41:02 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 10:41:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:41:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:41:02 INFO - Successfully installed psutil 10:41:02 INFO - Cleaning up... 10:41:02 INFO - Return code: 0 10:41:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:41:02 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')]} 10:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:02 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')]} 10:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:02 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 0x7fa8a2303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', '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 10:41:02 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 10:41:02 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 10:41:02 INFO - Using env: {'DISPLAY': ':0', 10:41:02 INFO - 'HOME': '/home/cltbld', 10:41:02 INFO - 'LANG': 'en_US.UTF-8', 10:41:02 INFO - 'LANGUAGE': 'en_US:en', 10:41:02 INFO - 'LOGNAME': 'cltbld', 10:41:02 INFO - 'MAIL': '/var/mail/cltbld', 10:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:02 INFO - 'MOZ_NO_REMOTE': '1', 10:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:02 INFO - 'NO_EM_RESTART': '1', 10:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:02 INFO - 'PWD': '/builds/slave/test', 10:41:02 INFO - 'SHELL': '/bin/bash', 10:41:02 INFO - 'SHLVL': '1', 10:41:02 INFO - 'TERM': 'linux', 10:41:02 INFO - 'TMOUT': '86400', 10:41:02 INFO - 'USER': 'cltbld', 10:41:02 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:02 INFO - '_': '/tools/buildbot/bin/python'} 10:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:41:02 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 10:41:02 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 10:41:02 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 10:41:02 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 10:41:02 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 10:41:02 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 10:41:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:41:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:41:04 INFO - Installing collected packages: mozsystemmonitor 10:41:04 INFO - Running setup.py install for mozsystemmonitor 10:41:04 INFO - Successfully installed mozsystemmonitor 10:41:04 INFO - Cleaning up... 10:41:04 INFO - Return code: 0 10:41:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fa8a2303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', '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 10:41:04 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 10:41:04 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 10:41:04 INFO - Using env: {'DISPLAY': ':0', 10:41:04 INFO - 'HOME': '/home/cltbld', 10:41:04 INFO - 'LANG': 'en_US.UTF-8', 10:41:04 INFO - 'LANGUAGE': 'en_US:en', 10:41:04 INFO - 'LOGNAME': 'cltbld', 10:41:04 INFO - 'MAIL': '/var/mail/cltbld', 10:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:04 INFO - 'MOZ_NO_REMOTE': '1', 10:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:04 INFO - 'NO_EM_RESTART': '1', 10:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:04 INFO - 'PWD': '/builds/slave/test', 10:41:04 INFO - 'SHELL': '/bin/bash', 10:41:04 INFO - 'SHLVL': '1', 10:41:04 INFO - 'TERM': 'linux', 10:41:04 INFO - 'TMOUT': '86400', 10:41:04 INFO - 'USER': 'cltbld', 10:41:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:04 INFO - '_': '/tools/buildbot/bin/python'} 10:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:41:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:41:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:41:06 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 10:41:06 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 10:41:06 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 10:41:06 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 10:41:06 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 10:41:06 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 10:41:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:41:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:41:07 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 10:41:07 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 10:41:07 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 10:41:07 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 10:41:07 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 10:41:07 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 10:41:07 INFO - Downloading docopt-0.6.1.tar.gz 10:41:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:41:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:41:07 INFO - Running setup.py install for blobuploader 10:41:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:41:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:41:07 INFO - Running setup.py install for requests 10:41:07 INFO - Running setup.py install for docopt 10:41:07 INFO - Successfully installed blobuploader requests docopt 10:41:07 INFO - Cleaning up... 10:41:08 INFO - Return code: 0 10:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:08 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 0x7fa8a2303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', '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 10:41:08 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 10:41:08 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 10:41:08 INFO - Using env: {'DISPLAY': ':0', 10:41:08 INFO - 'HOME': '/home/cltbld', 10:41:08 INFO - 'LANG': 'en_US.UTF-8', 10:41:08 INFO - 'LANGUAGE': 'en_US:en', 10:41:08 INFO - 'LOGNAME': 'cltbld', 10:41:08 INFO - 'MAIL': '/var/mail/cltbld', 10:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:08 INFO - 'MOZ_NO_REMOTE': '1', 10:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:08 INFO - 'NO_EM_RESTART': '1', 10:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:08 INFO - 'PWD': '/builds/slave/test', 10:41:08 INFO - 'SHELL': '/bin/bash', 10:41:08 INFO - 'SHLVL': '1', 10:41:08 INFO - 'TERM': 'linux', 10:41:08 INFO - 'TMOUT': '86400', 10:41:08 INFO - 'USER': 'cltbld', 10:41:08 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:08 INFO - '_': '/tools/buildbot/bin/python'} 10:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:41:08 INFO - Running setup.py (path:/tmp/pip-xYiMG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:41:08 INFO - Running setup.py (path:/tmp/pip-dMLSh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:41:08 INFO - Running setup.py (path:/tmp/pip-EKwkWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:41:08 INFO - Running setup.py (path:/tmp/pip-St1Q5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:41:08 INFO - Running setup.py (path:/tmp/pip-3hyzyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:41:08 INFO - Running setup.py (path:/tmp/pip-kYq6EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:41:08 INFO - Running setup.py (path:/tmp/pip-y4T3sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:41:08 INFO - Running setup.py (path:/tmp/pip-Dmzt8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:41:08 INFO - Running setup.py (path:/tmp/pip-KZTMkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:41:08 INFO - Running setup.py (path:/tmp/pip-akMQSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:41:08 INFO - Running setup.py (path:/tmp/pip-k76IWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:41:09 INFO - Running setup.py (path:/tmp/pip-TyKLqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:41:09 INFO - Running setup.py (path:/tmp/pip-gxidXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:41:09 INFO - Running setup.py (path:/tmp/pip-vzGJU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:09 INFO - Running setup.py (path:/tmp/pip-jZ3Zi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:41:09 INFO - Running setup.py (path:/tmp/pip-Hy2WdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:41:09 INFO - Running setup.py (path:/tmp/pip-bTqicu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:41:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:41:09 INFO - Running setup.py install for manifestparser 10:41:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:41:09 INFO - Running setup.py install for mozcrash 10:41:09 INFO - Running setup.py install for mozdebug 10:41:09 INFO - Running setup.py install for mozdevice 10:41:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:41:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:41:09 INFO - Running setup.py install for mozfile 10:41:09 INFO - Running setup.py install for mozhttpd 10:41:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Running setup.py install for mozinfo 10:41:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Running setup.py install for mozInstall 10:41:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Running setup.py install for mozleak 10:41:10 INFO - Running setup.py install for mozlog 10:41:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Running setup.py install for moznetwork 10:41:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Running setup.py install for mozprocess 10:41:10 INFO - Running setup.py install for mozprofile 10:41:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Running setup.py install for mozrunner 10:41:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:41:10 INFO - Running setup.py install for mozscreenshot 10:41:11 INFO - Running setup.py install for moztest 10:41:11 INFO - Running setup.py install for mozversion 10:41:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:41:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:41:11 INFO - Cleaning up... 10:41:11 INFO - Return code: 0 10:41:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:41: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')]} 10:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41: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')]} 10:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:11 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 0x7fa8a2303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', '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 10:41:11 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 10:41:11 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 10:41:11 INFO - Using env: {'DISPLAY': ':0', 10:41:11 INFO - 'HOME': '/home/cltbld', 10:41:11 INFO - 'LANG': 'en_US.UTF-8', 10:41:11 INFO - 'LANGUAGE': 'en_US:en', 10:41:11 INFO - 'LOGNAME': 'cltbld', 10:41:11 INFO - 'MAIL': '/var/mail/cltbld', 10:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:11 INFO - 'MOZ_NO_REMOTE': '1', 10:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:11 INFO - 'NO_EM_RESTART': '1', 10:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:11 INFO - 'PWD': '/builds/slave/test', 10:41:11 INFO - 'SHELL': '/bin/bash', 10:41:11 INFO - 'SHLVL': '1', 10:41:11 INFO - 'TERM': 'linux', 10:41:11 INFO - 'TMOUT': '86400', 10:41:11 INFO - 'USER': 'cltbld', 10:41:11 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:11 INFO - '_': '/tools/buildbot/bin/python'} 10:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:41:11 INFO - Running setup.py (path:/tmp/pip-J0xtdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:41:11 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)) 10:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:41:11 INFO - Running setup.py (path:/tmp/pip-sITiFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:41:11 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)) 10:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:41:11 INFO - Running setup.py (path:/tmp/pip-NLJL5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:41:11 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)) 10:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:41:11 INFO - Running setup.py (path:/tmp/pip-OtpMN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:41:11 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)) 10:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:41:11 INFO - Running setup.py (path:/tmp/pip-OcKrko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:41:11 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)) 10:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:41:11 INFO - Running setup.py (path:/tmp/pip-_WlxoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:41:11 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)) 10:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:41:11 INFO - Running setup.py (path:/tmp/pip-uOGfpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:41:11 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)) 10:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:41:11 INFO - Running setup.py (path:/tmp/pip-3d4B2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:41:12 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)) 10:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:41:12 INFO - Running setup.py (path:/tmp/pip-63D1Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:41:12 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)) 10:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:41:12 INFO - Running setup.py (path:/tmp/pip-Te6Cf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:41:12 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)) 10:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:41:12 INFO - Running setup.py (path:/tmp/pip-QQkfTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:41:12 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)) 10:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:41:12 INFO - Running setup.py (path:/tmp/pip-bVcXqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:41:12 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)) 10:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:41:12 INFO - Running setup.py (path:/tmp/pip-UAZ9Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:41:12 INFO - Running setup.py (path:/tmp/pip-mt0r2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:41:12 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)) 10:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:12 INFO - Running setup.py (path:/tmp/pip-sXvQCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:12 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)) 10:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:41:12 INFO - Running setup.py (path:/tmp/pip-8MiUu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:41:12 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)) 10:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:41:12 INFO - Running setup.py (path:/tmp/pip-y8SlDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:41:12 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)) 10:41:12 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)) 10:41:12 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)) 10:41:12 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)) 10:41:12 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)) 10:41:12 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)) 10:41:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:14 INFO - Downloading blessings-1.5.1.tar.gz 10:41:14 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 10:41:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:41:14 INFO - Installing collected packages: blessings 10:41:14 INFO - Running setup.py install for blessings 10:41:14 INFO - Successfully installed blessings 10:41:14 INFO - Cleaning up... 10:41:14 INFO - Return code: 0 10:41:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:41:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:41:14 INFO - Reading from file tmpfile_stdout 10:41:14 INFO - Current package versions: 10:41:14 INFO - argparse == 1.2.1 10:41:14 INFO - blessings == 1.5.1 10:41:14 INFO - blobuploader == 1.2.4 10:41:14 INFO - docopt == 0.6.1 10:41:14 INFO - manifestparser == 1.1 10:41:14 INFO - mozInstall == 1.12 10:41:14 INFO - mozcrash == 0.16 10:41:14 INFO - mozdebug == 0.1 10:41:14 INFO - mozdevice == 0.47 10:41:14 INFO - mozfile == 1.2 10:41:14 INFO - mozhttpd == 0.7 10:41:14 INFO - mozinfo == 0.9 10:41:14 INFO - mozleak == 0.1 10:41:14 INFO - mozlog == 3.1 10:41:14 INFO - moznetwork == 0.27 10:41:14 INFO - mozprocess == 0.22 10:41:14 INFO - mozprofile == 0.28 10:41:14 INFO - mozrunner == 6.11 10:41:14 INFO - mozscreenshot == 0.1 10:41:14 INFO - mozsystemmonitor == 0.0 10:41:14 INFO - moztest == 0.7 10:41:14 INFO - mozversion == 1.4 10:41:14 INFO - psutil == 3.1.1 10:41:14 INFO - requests == 1.2.3 10:41:14 INFO - wsgiref == 0.1.2 10:41:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:41: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')]} 10:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41: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')]} 10:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:14 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 0x7fa8a2303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', '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 10:41:14 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 10:41:14 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 10:41:14 INFO - Using env: {'DISPLAY': ':0', 10:41:14 INFO - 'HOME': '/home/cltbld', 10:41:14 INFO - 'LANG': 'en_US.UTF-8', 10:41:14 INFO - 'LANGUAGE': 'en_US:en', 10:41:14 INFO - 'LOGNAME': 'cltbld', 10:41:14 INFO - 'MAIL': '/var/mail/cltbld', 10:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:14 INFO - 'MOZ_NO_REMOTE': '1', 10:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:14 INFO - 'NO_EM_RESTART': '1', 10:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:14 INFO - 'PWD': '/builds/slave/test', 10:41:14 INFO - 'SHELL': '/bin/bash', 10:41:14 INFO - 'SHLVL': '1', 10:41:14 INFO - 'TERM': 'linux', 10:41:14 INFO - 'TMOUT': '86400', 10:41:14 INFO - 'USER': 'cltbld', 10:41:14 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:14 INFO - '_': '/tools/buildbot/bin/python'} 10:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:41:15 INFO - Cleaning up... 10:41:15 INFO - Return code: 0 10:41:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:41:15 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')]} 10:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:15 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')]} 10:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:15 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 0x7fa8a2303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', '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 10:41:15 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 10:41:15 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 10:41:15 INFO - Using env: {'DISPLAY': ':0', 10:41:15 INFO - 'HOME': '/home/cltbld', 10:41:15 INFO - 'LANG': 'en_US.UTF-8', 10:41:15 INFO - 'LANGUAGE': 'en_US:en', 10:41:15 INFO - 'LOGNAME': 'cltbld', 10:41:15 INFO - 'MAIL': '/var/mail/cltbld', 10:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:15 INFO - 'MOZ_NO_REMOTE': '1', 10:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:15 INFO - 'NO_EM_RESTART': '1', 10:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:15 INFO - 'PWD': '/builds/slave/test', 10:41:15 INFO - 'SHELL': '/bin/bash', 10:41:15 INFO - 'SHLVL': '1', 10:41:15 INFO - 'TERM': 'linux', 10:41:15 INFO - 'TMOUT': '86400', 10:41:15 INFO - 'USER': 'cltbld', 10:41:15 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:15 INFO - '_': '/tools/buildbot/bin/python'} 10:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:15 INFO - Downloading/unpacking jsonschema 10:41:15 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 10:41:15 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 10:41:15 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 10:41:15 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 10:41:15 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 10:41:15 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 10:41:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:41:16 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 10:41:16 INFO - Downloading/unpacking functools32 (from jsonschema) 10:41:16 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 10:41:16 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 10:41:16 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 10:41:16 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 10:41:16 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 10:41:16 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 10:41:17 INFO - Downloading functools32-3.2.3-2.tar.gz 10:41:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:41:17 INFO - warning: no files found matching '*.txt' 10:41:17 INFO - no previously-included directories found matching 'build' 10:41:17 INFO - no previously-included directories found matching 'dist' 10:41:17 INFO - no previously-included directories found matching '.git*' 10:41:17 INFO - Installing collected packages: jsonschema, functools32 10:41:17 INFO - Running setup.py install for functools32 10:41:17 INFO - warning: no files found matching '*.txt' 10:41:17 INFO - no previously-included directories found matching 'build' 10:41:17 INFO - no previously-included directories found matching 'dist' 10:41:17 INFO - no previously-included directories found matching '.git*' 10:41:17 INFO - Successfully installed jsonschema functools32 10:41:17 INFO - Cleaning up... 10:41:17 INFO - Return code: 0 10:41:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:41:17 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')]} 10:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:17 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')]} 10:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:17 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 0x7fa8a2303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', '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 10:41:17 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 10:41:17 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 10:41:17 INFO - Using env: {'DISPLAY': ':0', 10:41:17 INFO - 'HOME': '/home/cltbld', 10:41:17 INFO - 'LANG': 'en_US.UTF-8', 10:41:17 INFO - 'LANGUAGE': 'en_US:en', 10:41:17 INFO - 'LOGNAME': 'cltbld', 10:41:17 INFO - 'MAIL': '/var/mail/cltbld', 10:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:17 INFO - 'MOZ_NO_REMOTE': '1', 10:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:17 INFO - 'NO_EM_RESTART': '1', 10:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:17 INFO - 'PWD': '/builds/slave/test', 10:41:17 INFO - 'SHELL': '/bin/bash', 10:41:17 INFO - 'SHLVL': '1', 10:41:17 INFO - 'TERM': 'linux', 10:41:17 INFO - 'TMOUT': '86400', 10:41:17 INFO - 'USER': 'cltbld', 10:41:17 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:17 INFO - '_': '/tools/buildbot/bin/python'} 10:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:17 INFO - Downloading/unpacking flake8 10:41:17 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 10:41:17 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 10:41:17 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 10:41:17 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 10:41:17 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 10:41:17 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 10:41:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:41:19 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 10:41:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:41:19 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 10:41:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:19 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 10:41:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:41:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:41:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:41:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:41:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:41:20 INFO - no previously-included directories found matching 'docs/_build' 10:41:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:41:20 INFO - Running setup.py install for pep8 10:41:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:41:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:41:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:41:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:41:20 INFO - no previously-included directories found matching 'docs/_build' 10:41:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:41:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:41:20 INFO - Cleaning up... 10:41:20 INFO - Return code: 0 10:41:20 INFO - Running post-action listener: _resource_record_post_action 10:41:20 INFO - Running post-action listener: _start_resource_monitoring 10:41:20 INFO - Starting resource monitoring. 10:41:20 INFO - ##### 10:41:20 INFO - ##### Running install step. 10:41:20 INFO - ##### 10:41:20 INFO - Running pre-action listener: _resource_record_pre_action 10:41:20 INFO - Running main action method: install 10:41:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:41:20 INFO - Reading from file tmpfile_stdout 10:41:20 INFO - Detecting whether we're running mozinstall >=1.0... 10:41:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:41:20 INFO - Reading from file tmpfile_stdout 10:41:20 INFO - Output received: 10:41:20 INFO - Usage: mozinstall [options] installer 10:41:20 INFO - Options: 10:41:20 INFO - -h, --help show this help message and exit 10:41:20 INFO - -d DEST, --destination=DEST 10:41:20 INFO - Directory to install application into. [default: 10:41:20 INFO - "/builds/slave/test"] 10:41:20 INFO - --app=APP Application being installed. [default: firefox] 10:41:20 INFO - mkdir: /builds/slave/test/build/application 10:41:20 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'] 10:41:20 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 10:41:36 INFO - Reading from file tmpfile_stdout 10:41:36 INFO - Output received: 10:41:36 INFO - /builds/slave/test/build/application/firefox/firefox 10:41:36 INFO - Running post-action listener: _resource_record_post_action 10:41:36 INFO - ##### 10:41:36 INFO - ##### Running run-tests step. 10:41:36 INFO - ##### 10:41:36 INFO - Running pre-action listener: _resource_record_pre_action 10:41:36 INFO - Running main action method: run_tests 10:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:41:36 INFO - Python 2.7.3 10:41:36 INFO - Return code: 0 10:41:36 INFO - grabbing minidump binary from tooltool 10:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:36 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 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:41:36 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 10:41:36 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 10:41:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:41:36 INFO - Return code: 0 10:41:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:41:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:41:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:41:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:41:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:41:37 INFO - Return code: 0 10:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:41:37 INFO - Using env: {'DISPLAY': ':0', 10:41:37 INFO - 'HOME': '/home/cltbld', 10:41:37 INFO - 'LANG': 'en_US.UTF-8', 10:41:37 INFO - 'LANGUAGE': 'en_US:en', 10:41:37 INFO - 'LOGNAME': 'cltbld', 10:41:37 INFO - 'MAIL': '/var/mail/cltbld', 10:41:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:41:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:37 INFO - 'MOZ_NO_REMOTE': '1', 10:41:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:37 INFO - 'NO_EM_RESTART': '1', 10:41:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:37 INFO - 'PWD': '/builds/slave/test', 10:41:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:41:37 INFO - 'SHELL': '/bin/bash', 10:41:37 INFO - 'SHLVL': '1', 10:41:37 INFO - 'TERM': 'linux', 10:41:37 INFO - 'TMOUT': '86400', 10:41:37 INFO - 'USER': 'cltbld', 10:41:37 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196', 10:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:37 INFO - '_': '/tools/buildbot/bin/python'} 10:41:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:41:37 INFO - mozversion application_buildid: 20160111100228 10:41:37 INFO - mozversion application_changeset: 436e2013c50f184a17144ee878e736b2607fef96 10:41:37 INFO - mozversion application_display_name: Nightly 10:41:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:41:37 INFO - mozversion application_name: Firefox 10:41:37 INFO - mozversion application_remotingname: firefox 10:41:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:41:37 INFO - mozversion application_vendor: Mozilla 10:41:37 INFO - mozversion application_version: 46.0a1 10:41:37 INFO - mozversion platform_buildid: 20160111100228 10:41:37 INFO - mozversion platform_changeset: 436e2013c50f184a17144ee878e736b2607fef96 10:41:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:41:37 INFO - mozversion platform_version: 46.0a1 10:41:37 INFO - using testdate: 1452537697 10:41:37 INFO - actual date: 1452537697 10:41:37 INFO - starting webserver on 'localhost:37170' 10:41:37 INFO - SUITE-START | Running 3 tests 10:41:37 INFO - TEST-START | dromaeo_css 10:41:37 INFO - operating with platform_type : linux_ 10:41:37 INFO - Initialising browser for dromaeo_css test... 10:41:37 INFO - TEST-INFO | started process 26154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2QBi6M/profile http://localhost:37170/getInfo.html) 10:41:41 INFO - PROCESS | 26154 | __metrics Screen width/height:1600/1200 10:41:42 INFO - PROCESS | 26154 | colorDepth:24 10:41:42 INFO - PROCESS | 26154 | Browser inner width/height: 1024/697 10:41:42 INFO - PROCESS | 26154 | __metrics 10:41:42 INFO - PROCESS | 26154 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:41:42 INFO - PROCESS | 26154 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:41:43 INFO - TEST-INFO | 26154: exit 0 10:41:43 INFO - Browser initialized. 10:41:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:41:43 INFO - TEST-INFO | started process 26246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2QBi6M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:55 INFO - PROCESS | 26246 | RSS: Main: 148836352 10:41:55 INFO - PROCESS | 26246 | 10:42:46 INFO - PROCESS | 26246 | 1452537766346 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] 10:44:58 INFO - PROCESS | 26246 | Cycle 1(1): loaded http://localhost:37170/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37170/tests/dromaeo/cssquery-ext.html) 10:44:59 INFO - PROCESS | 26246 | RSS: Main: 238989312 10:44:59 INFO - PROCESS | 26246 | 10:48:01 INFO - PROCESS | 26246 | Cycle 1(1): loaded http://localhost:37170/tests/dromaeo/cssquery-ext.html (next: http://localhost:37170/tests/dromaeo/cssquery-jquery.html) 10:48:02 INFO - PROCESS | 26246 | RSS: Main: 223469568 10:48:02 INFO - PROCESS | 26246 | 10:51:04 INFO - PROCESS | 26246 | Cycle 1(1): loaded http://localhost:37170/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37170/tests/dromaeo/cssquery-mootools.html) 10:51:04 INFO - PROCESS | 26246 | RSS: Main: 241319936 10:51:04 INFO - PROCESS | 26246 | 10:54:06 INFO - PROCESS | 26246 | Cycle 1(1): loaded http://localhost:37170/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37170/tests/dromaeo/cssquery-prototype.html) 10:54:07 INFO - PROCESS | 26246 | RSS: Main: 210358272 10:54:07 INFO - PROCESS | 26246 | 10:57:10 INFO - PROCESS | 26246 | Cycle 1(1): loaded http://localhost:37170/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37170/tests/dromaeo/cssquery-yui.html) 10:57:11 INFO - PROCESS | 26246 | RSS: Main: 213348352 10:57:11 INFO - PROCESS | 26246 | 11:00:13 INFO - PROCESS | 26246 | Cycle 1(1): loaded http://localhost:37170/tests/dromaeo/cssquery-yui.html (next: http://localhost:37170/tests/dromaeo/cssquery-dojo.html) 11:00:13 INFO - PROCESS | 26246 | RSS: Main: 257380352 11:00:13 INFO - PROCESS | 26246 | 11:00:13 INFO - PROCESS | 26246 | __start_tp_report 11:00:13 INFO - PROCESS | 26246 | _x_x_mozilla_page_load 11:00:13 INFO - PROCESS | 26246 | _x_x_mozilla_page_load_details 11:00:13 INFO - PROCESS | 26246 | |i|pagename|runs| 11:00:13 INFO - PROCESS | 26246 | |0;dojo.html;2571.237644993667;2634.7101818799943;2643.7884969202464;2656.1102030819675;2663.5871439926814;4338.284183109783;4436.935135567464;4449.911001779967;4462.397576327195;4483.977580112099;4510.97744511277;4558.635309175266;4615.492295847454;4617.399738034051;4649.558291962267;4182.414461975326;4199.895002624929;4261.2329780639475;4295.720778149426;4320.6327462165755;4270.132974749736;4276.016516201275;4322.502912165094;4324.22164010478;4378.036831896993;4090.325096359097;4126;4184.979075104636;4189.853355132586;4215.45199124115;4223.113146239293;4233.534311225793;4247.91504169918;4261.808218630169;4279.636230920375;4207.936880946758;4212.85255016076;4230.78846057699;4256.404103425523;4261.616454519108;4299.441072660566;4386.254336762758;4418.270985287424;4496.7077139985795;4496.707713998612;4916.041371932474;4946.87632809179;4954.063498551869;4959.950400495985;4994.525520075587;4967.329410529568;4967.453580106186;4975.651704380694;4978.079055374767;4978.701277923336;4393.736375817429;4499.797509112131;4500.8649740507835;4510.436195475566;4610.170169369479;5017.523335283142;5019.0463811875625;5025.346704928336;5043;5045.344105266292;4813.879653008633;4822.638302127354;4824.372831531879;4825.975870120697;4867.634927380461;4686;4795.976020119877;4802.975985120122;4905.779239934212;4955.752212389366;4800.5199480052415;4867.70793752376;4869.805207791719;4878.048780487771;4910.06708725341;4804.399450068741;4823.27650852375;4826.7827947742435;4833.492483289274;4873.049755297683;4026.798660066985;4124.1957818225155;4158.875233742992;4161.354176485466;4201.138766552849;3594.6405359463843;3620.5112309837837;3688.889333320005;3689.0408493791806;3719.051641831316;4268.658507319407;4274.380214868826;4284.271673815397;4290.37789520524;4315.201687687788;4730.077634861169;4934.506549345037;4942.35749352589;4943.332650092263;4984.053029924376;4192.832286708497;4200.138971510833;4232.6190642841675;4342.392065110887;4345.804438800262;4396.098799746044;4440.134173836135;4440.245158323093;4451.221036318696;4489.483709373399;4717.646176536773;4719.646026547954;4719.646026548091;4723.338732577373;4767.213409787346;4722.409698787652;4826.927596085991;4843;4845;4949.653524253267;4670.065986802721;4720.291956206596;4722.645801564965;4725.905481890274;4756.262779269219;4846.588040016638;4846.757662116951;4859.562639362474;4860.805567777249;4907.214845624683;4744.4069491313585;4828.589569886599;4859.878503037452;4860.343853579863;4954.529319714621;4731.384919960383;4772;4777.163996300703;4779.283107533898;4818.590419814355;4763.54746299101;4773.64197685182;4773.928391074067;4775.068861572099;4822.276658501253;4490.101979604157;4574.748388838646;4616.953830461653;4628.074385122922;4760.9285860711425;4782.569568738831;4818.831340903192;4821.710697358029;4825.059113472979;4859.878503037452;4733.077049975222;4733.881652958704;4734.7632618369635;4739.052189562032;4765.380500534909 11:00:13 INFO - PROCESS | 26246 | |1;ext.html;479.3887793063843;490.7104808163183;505.2875445621673;510.1607855078396;510.3747908811704;26301.60547591785;27090.458190836198;32400.67599324009;32837.17907052325;32855.507167392505;35968.280634387294;36474;36480.452793208126;36491.81754091232;36558.81720591393;7531.171571127172;7739.110002349717;7741.458097933147;7746.651400686983;7748.2251774822635;7428.962855185743;7555.622218889061;7558.319751222389;7570.583617901013;7571.053618297713;7659.119201291839;7737.57443340616;7739.342155916754;7780.727674531393;7789.065312162548;7682.423818213629;7721.652525636304;7747.302742753123;7753.689852405897;7755.030621172354;7644.503107298064;7742.922570774276;7778.494397864178;7781.5331080135375;7785.532868027936;36009.27981440356;36616.63383366159;36839;36844;36877.26245475102;2835.5888396182645;2895.3340731631633;2906.5058939980254;2944.469995400827;2952.601398811176;28248.576271355945;28286.575701364494;28321.716782832114;28361.14916552486;28436.857815710788;3256;3306.6751760036705;3312.420326442863;3344.48160535115;3376.5104059911178;210967;211029;211655;212031.99999999846;212688;45177.774111129234;49813.50186498161;50044.49955500471;50062.749686252064;50224.748876255384;39898.40152397716;40054.59945400567;40125.799371002955;40132.59867401347;40148.397774033416;13630;14183.439821619613;14246.216458094905;14312.928435357757;14313.499027533986;9968.601255949681;10008.399496030115;10019.448930308758;10032.69901902944;10036.146927511243;15012.099274043592;15540.300686469136;17101.520279559394;17347.3061077558;18707.193920911974;7286.599237041907;7466.589337586485;7602.885956710654;7618.733344332922;7690.232325755684;840.8948881389827;847.8643417053241;894.181823631383;912.1380295620708;922.9030951750104;25546.23361299164;26072.739272607032;26160.084397046012;26445.867770661025;26465.867670661522;903.1645727701849;914.7895983923735;954.4511905654276;982.8771403574553;1053.4469403563191;12125.636230913087;12292.078094142797;12293.446794894073;12296.139270251175;12320;249194;254327;254769;254852;255772;43124.568754312684;43316.56683433188;43401.565984340385;43428.78285608615;43453.34819977703;1222.908281878845;1228.336698182971;1233.3586535001748;1233.9876601233873;1235.4131787400913;22782.430439239153;23450.413739656644;23610.645840312754;23657.52684946257;23679.171229007592;34623.13442163966;34891.127721806144;35418.8229058853;36062.63937360698;40100;158539;158588;159134;159699;159823.20088399484;24792.25623231306;25134;25145.748542514342;25173.622395664446;25199.992000320515;29533.704662953096;32186.83906580452;35428.29143417169;37320.45938408944;37594.43608345932;29782.10653680393;29910.70089299079;30617;31239.219019524695;31440.685593143775;30229.546556801226;30248.84875575608;30512;30560.84719576388;30663.693363066082;32083;32476.350472990882;32501;32856.50715239225;32940.1764955878;26767.598486022336;27918.30204244829;31776.523352149274;32249;32313.676863232005;22066.558668826856;22222.666659999788;22456;22485.5502889938;22539.774602254423 11:00:13 INFO - PROCESS | 26246 | |2;jquery.html;333.15266845342575;334.3830632483069;334.7071312601473;341.09949732705644;341.13862497194594;11709.180357374988;12152.27086374816;14417.711645767078;14654.954091538833;15784.842151578496;14138.151710897353;14432.42270309189;14669.559913202595;15369.692606147899;15466.458673946414;4493.820247190125;4778.498257682945;5024.422191447976;5711.228984087136;5715.3141623005085;3687.668109870111;3871.2451072040963;5565.6104072714725;5796.82609521715;5797.681127537984;5578.553715702734;5652.236803383774;5712.8857422851515;5713.400092990239;5761.769529218826;5613.775448982035;5635.887282254373;5644.887102257973;5655.773769049233;5690.032694441934;4828.879278018043;5067.923981140286;5069.138246498104;5072.923906141411;5077.771500282496;17766.822331776777;17834.91082544592;17923.641527169384;18197;18207.08964551767;1881.840043596296;1904.076522886399;1919.3090487424515;1997.3508609701905;2109.34610270815;12158.209716368408;12210.694732631666;12257.203281786744;12294.75410491785;12354.567590134302;1668.0658831054648;1679.3702361614394;1715.468204856486;1723.7931448226168;1777.6355847051323;45924.770376147906;45961;46672.06655866898;47009.05981880378;47104.76447617774;9053.864192037125;9117.361784675142;9210.677626283183;9225.446473211628;9289.674861379819;11818.586349477728;11826.408679565988;11830.822537661941;11835.230710003994;11843.940780296043;7052.188998265163;7056.15326160864;7091;7098.503104782616;7111.040009598742;6795.966020169966;6814.93185068143;6850.314968503109;6863.931360686429;6865.485088618374;4774.092922344744;5047.697138171721;5551.916721249185;5575.916361254584;5641.2384328116;1586.4050980882168;1645.3418632547077;1651.5210588929317;1652.8760342974324;1669.2655231698013;895.3463971300987;916.4409710076848;917.7522069041455;961.9466683981029;975.6823083215644;11901.345426001653;13755.587332380044;14075.648108797363;14992.250387480583;15170;833.9416240863081;849.7323343146888;862.1895418306772;943.8631398447324;967.874176357069;8582.957085214533;9110.134537218953;9146.661468563927;9177.678781242625;9308.255339572954;394084;395185;396515;397205;399530;52867.73566132145;52904.47095529072;53378;54074;54833.177502337494;1099.1261946752352;1106.0377471599759;1109.367660433545;1119.2948442481347;1131.2759833706434;12668.239905605693;13383.19700817954;13428.328583570586;13666.863331366956;13808.1024733392;27723;28532.286692832844;30019.3996120072;30463.238419039702;30553.54169687501;35396.46905296474;35797.28405431929;35962.46056309105;36559.45160822643;37544.249115018094;6265.27949285838;6400.51996100285;6544.934550654432;6616.4045235929;6671.532992690659;7972.681092756225;8736.868946965673;9476.763080923032;9601.519924003911;9603.37578057424;7641.083070031409;7736.071671399468;7798.844023119619;7824.334931530883;7925.603719813871;6739.865202696017;7447.590382528796;8067.636956336862;8071.273585377344;8329.750107496784;7623.16145224036;7679.654415551426;7684.5773482459;7767.883481747665;7786.961065194638;6133.53998450127;6247.969085100907;6362.6818659067785;6429.935700642934;6465.579737317059;7100.857982840417;7799.298063174341;7807.258310460497;7860.449768516149;7915.564643944638 11:00:13 INFO - PROCESS | 26246 | |3;mootools.html;1058.2645061682124;1383.8339399272086;1392.456941792701;1521.5815650696056;1759.3578343904471;6310.558260921737;7280.635968201588;7454.142773581039;7466.51467654602;7467.253274672544;7196.064511613483;7365.15300740415;7376.74181403651;7382;7446.069241344832;1835.3851459760997;1870.7848597411337;1885.3778253176488;2172.1094351315965;2203.911843526257;1844.8985305808176;1852.21280955594;2157.611629906616;2209.6795964585126;2214.4353189936623;2135.4661334666334;2170.0885628036262;2175.8041776240134;2176.8789073627095;2177.3032629558547;2128.4040468668795;2153.547754971458;2154.762976072631;2156.5902478529188;2159.5356998245375;2106.441792924876;2130.8295336373053;2135.16728475893;2136.2309568555306;2137.754158271803;7288.56268623879;7322.670479828367;7329;7348.485606007582;7354.30850904295;4421.889452763675;4523.954760452386;4531.093781243764;4547.7271363717955;4548.613367863735;2841.4743272494657;2886.841223732694;2907.6220091387986;2912.286489809989;2937.104183224116;911.4166933162782;1680.5126513311125;1719.3982106262708;1732.1252767352532;1739.2781995471864;9804.068613481708;9916.504174791231;9923.503824808731;9931.404115753077;9958.203343732484;3839.5968423315708;3841.442990766379;3887.727859049896;3906.8437262509183;3993.660538854172;8064.153263907206;8073.515589064557;8091.838163236703;8091.87862182056;8098.433109682265;4503.166914120898;4506.076254367847;4507.233770259064;4512.661550383735;4514.503404625489;4073.9796301018305;4093.1609020151395;4101.446304748881;4107.240160570304;4107.856225032109;3330.4338262495435;3353.312570922955;3386.1873150443716;3388.711959483422;3405.5743032120986;879.445949052093;911.3939230411702;1028.99485502572;1034.7671773850973;1035.2597892506744;907.0249481807084;928.1414691410419;931.6413180925392;942.4769253064615;1207.8671346151916;6944.097267355312;6964.965175174092;6971.407430368476;6971.616561089088;6977.476689248327;1023.3655133817081;1030.1964467715195;1035.9326643768131;1046.4663021858908;1064.292245656645;5540;5568.582356323292;5647.632903861236;5663.008973429633;5673;9380.67167649129;9577.329586928987;9582.28132890036;9711.125998660013;9748.463834489172;9378.920169726054;9523.428594284227;9596.088371604686;9638.566264518113;9646.758831029281;7302.96348518254;7431.033965584439;7439.293267139613;7443.925560744323;7448.702051917862;6921.48088893325;7021.754238601625;7055.223925368308;7067.293270672892;7078.18600860887;8292.460990035628;8327.750167494985;8458.873116903374;8549.743507694779;8561.10108438605;8546.316294696286;8765.254953329038;8786.912130878609;8800.251978581893;8819.91180088191;6420.133282007057;6543.901841472287;6549.345065493603;6549.8690026200165;6553.0170474429215;7235.963820180866;7280.126384833854;7328.3404493595835;7340.449466290156;7346.302101300368;6931.2375638678695;6985.650717464005;7035.648217589202;7098.3256590623805;7117.039199707973;6887.449004079762;6904.482163837632;7015.193252775996;7072.929270707227;7096.077509923677;7012.298770122947;7122.21655617892;7123;7125.786226413215;7128.572285662877;6431.421172094347;6522.934770652233;6541.182352205974;6571.080048793077;6583.670816459254;6436.324185960594;6523.510736694861;6525.9021114684265;6528.314526974599;6539.411452969255 11:00:13 INFO - PROCESS | 26246 | |4;prototype.html;312.87015888406313;317.19907234233574;318.813494105948;322.7982510930668;330.55210190192287;5240.449752775956;5268.341457317835;5269.8155564555245;5280.762365693538;5290.550303224221;5231.163013917774;5240.449752775951;5250.921236181461;5252.133397989327;5260.579153667707;3958.8218530166214;4041.3937909313545;4058;4131.710780245384;4139.172165566891;4124.546299907008;4140;4151.2112698587325;4151.588459923625;4152.875413737577;4089.4274801527663;4145.7719825409595;4146.481689788777;4151.418801367796;4152.0657851983215;3906.824192911326;4002.4596679448337;4025.4565633639377;4137.81379837905;4165.75005499671;3676.6874815640704;3684.207895302496;3684.9631503684886;3688.5942546319884;3692.2430901665093;5044.470330615306;5048.3184770056305;5048.747562621854;5051.1413059779925;5058.367704036996;4758.571728544413;4767.451743049559;4768.904621907543;4774.928376074362;4776.355192049098;5301.3373328333955;5520.91718624221;5521.723913804334;5522.950639378505;5546.112621980464;3923.7253392262555;3924.4113382992496;3925.685945124383;3926.0773718176206;3929.8231579578987;5737.3975732548315;5824.417558244184;5825.097109947965;5832.12518122285;5840.561957853178;4048.4939382577177;4058.1477889643506;4058.2086493133556;4059.330210515291;4063.9796801015805;3827.7894715790344;3849.8075096245075;3866.9226615468096;3952.9011774705864;4105.876823695294;4541.3869127668;4543.61379282758;4549.340345649863;4551.613112885442;4556.11155824611;5384.434634363413;5396.1366181410785;5526.281583394213;5537.390887002426;5592.608517403824;1430.7281616492833;1454.1783892101141;1454.5418193269086;1454.5709015840353;1454.6217983324411;983.1692220074026;988.906053924876;992.7220378294089;1009.28340877976;1009.601207523039;4901.166801643729;4917.704937703749;4918.163912134945;4922.286268491049;4923.90152196954;5746.913796293059;5749.195112684228;5750.7987220447085;5763.423657634203;5765.221695071112;4899.583535399531;4903.141950158708;4903.215485522299;4904.779284932187;4908.361912951294;2968.732814046746;3030.3030303030428;3047.9085627431214;3057.770667199969;3075.4925437302595;5517.586181036439;5519.69641669712;5521.917171242435;5537.224788529609;5543.168524721244;5939.4951429129005;5952.136940143741;5956.285245770535;5964.940350596438;5967.1347654589845;5397.2443857859935;5511.559075273888;5517.393086760453;5520.696361700065;5524.917126243109;5778.191053252464;5792.102224155263;5805.506531944832;5811.709414529341;5816.76732930678;5676.262085928803;5676.971615141898;5678.858028549319;5681.0910254359105;5684.346300175533;5504.311961004874;5520.033994050945;5532.972335138298;5537.723113844372;5540.806071787468;3900.6294402031763;4015.4177644242004;4021.819018144249;4025.295573274607;4038.293298672662;5669.518090962314;5706.144078388109;5729.140628905698;5761.769529218785;5762.193292938908;5525.336959564878;5537.612367134262;5538.0585300499815;5538.723063846872;5540.833774986757;5418.431064738145;5529.612927095226;5543.473370029841;5549.805756798492;5550.75021624036;5417.729113544228;5423.647462914898;5427.674339539641;5427.945720542902;5428.809991650273;5550;5566.526845218202;5571.247881535941;5571.9442805571425;5576.498115169654;5435.864103397446;5440.156775699773;5449.891002180014;5454.154606036071;5456.708182563412 11:00:13 INFO - PROCESS | 26246 | |5;yui.html;696.6029363262938;703.4161645833958;712.3873468816819;719.0759873562473;745.0686641697874;10871.619493317736;10891.183161262898;11008.559657613705;11031.062359699425;11142.27575207611;11449.141314401411;11505.942470287659;11519.712007199823;11523.884761152385;11524.539018439253;619.1610367951429;628.2680677011276;784.30588928798;792.4294507954293;802.7070119406433;801.3669201330941;805.5931754463987;808.3452403553111;808.8624933761246;809.4010432280129;846.8856704344896;848.8005318750089;849.0151424347758;849.1593322610632;849.5072857742525;640.7308930249307;649.9902501462482;816.244973399609;830.6511265268541;831.9001719793603;613.7483631710977;615.6398506873485;615.9414855588711;615.989776766104;616.0820377637333;10708.625198118028;10726.517306721216;10816.080633146192;10817.405042722647;10820.350778953289;10598.62904798336;10607.946960265226;10754.838677419766;10907.400092994882;11145;8595.871061934076;8706.6517339307;8772.473651580925;8811.94256689195;9010.59452324647;3108.1763332716846;3124.078396872905;3143.685631436861;3158.6209654841564;3179.998300535324;37077.25845483075;37247.81376093129;37278.25443491142;37534.436983445274;37621;8619.655213791504;8621.741347759576;8721.869171962426;8746.081661425585;8750.081241469681;14014.439422423193;14061.507847225297;14090.295485225697;14091.154530728189;14103.85896141046;5978.372270911578;6180.629162250189;6212.937870621236;6382.521310901701;6537.248216455074;3662.9450558241647;3693.4829123922673;3743.232637309345;3755.6244375562223;3764.435334699817;2717.30708669292;2739.657542807149;2743.478739039576;2744.108164846393;2750.7936904732223;510.3951817096752;512.1728408620052;523.1237676891268;529.8781280305551;531;436.6005105328589;446.31071394770635;552.6987791653559;553.5239693863274;555.5694336888944;6969.965150174318;6991.89512157318;7069.222385537587;7119.21688614252;7279.6360181990685;500.2321436594809;544.1076634319719;561.0602241245979;579.5218944370911;581.6306645280193;3319.0872510059444;3374.645662205482;3383.1711230748624;3387.9491807622903;3504.404251277289;44010.33984490235;44768.55231447644;44780.3282950756;44802;44815.55184448114;38779.321157168255;39608.405873911914;39709.20581588352;40018.799906000284;40059.799701001306;36112.81943590265;36306.818465907505;36417.27165456729;36607.08482287964;36903.63096369056;6684.097646817618;6787.66061696923;6806.149231346082;6854.971754236705;6866.622335771581;28290.57564136581;28419.857900710365;28457.00400486056;28866.855665721538;28935;32455.188620284684;34062.31875362528;35363.646363536034;36137.63862361343;36452.27095458129;8577.871331930151;8601.483910965362;8602.096779838026;8653.740387788377;8931.687390941286;9048.039789931327;9048.230900373543;9157.86263206039;9194.49430281341;9284.72145835626;8383.455075420079;8622.353323500887;8626.266767324847;8702.56487175626;8722.08418116114;8579.871301930601;8591.269742071994;8612.61243244043;8634.740957771277;8644.135586441556;8236.464629799044;8311.085780564254;8397.874031889649;8428.819965204999;8549.187827156411;7420.703171873281;7651.081870175614;7744.65149068282;7768;7800.92199078002;7546.773596792105;7619.818928066159;7738.806529836799;7801.258880406353;7988.720394786154 11:00:13 INFO - PROCESS | 26246 | __end_tp_report 11:00:13 INFO - PROCESS | 26246 | __start_cc_report 11:00:13 INFO - PROCESS | 26246 | _x_x_mozilla_cycle_collect,884 11:00:13 INFO - PROCESS | 26246 | __end_cc_report 11:00:13 INFO - PROCESS | 26246 | __startTimestamp1452538813843__endTimestamp 11:00:13 INFO - PROCESS | 26246 | 11:00:13 INFO - PROCESS | 26246 | ------- Summary: start ------- 11:00:13 INFO - PROCESS | 26246 | Number of tests: 6 11:00:13 INFO - PROCESS | 26246 | 11:00:13 INFO - PROCESS | 26246 | [#0] dojo.html Cycles:165 Average:4531.44 Median:4719.65 stddev:460.89 (9.8%) stddev-sans-first:435.90 11:00:13 INFO - PROCESS | 26246 | Values: 2571.2 2634.7 2643.8 2656.1 2663.6 4338.3 4436.9 4449.9 4462.4 4484.0 4511.0 4558.6 4615.5 4617.4 4649.6 4182.4 4199.9 4261.2 4295.7 4320.6 4270.1 4276.0 4322.5 4324.2 4378.0 4090.3 4126.0 4185.0 4189.9 4215.5 4223.1 4233.5 4247.9 4261.8 4279.6 4207.9 4212.9 4230.8 4256.4 4261.6 4299.4 4386.3 4418.3 4496.7 4496.7 4916.0 4946.9 4954.1 4960.0 4994.5 4967.3 4967.5 4975.7 4978.1 4978.7 4393.7 4499.8 4500.9 4510.4 4610.2 5017.5 5019.0 5025.3 5043.0 5045.3 4813.9 4822.6 4824.4 4826.0 4867.6 4686.0 4796.0 4803.0 4905.8 4955.8 4800.5 4867.7 4869.8 4878.0 4910.1 4804.4 4823.3 4826.8 4833.5 4873.0 4026.8 4124.2 4158.9 4161.4 4201.1 3594.6 3620.5 3688.9 3689.0 3719.1 4268.7 4274.4 4284.3 4290.4 4315.2 4730.1 4934.5 4942.4 4943.3 4984.1 4192.8 4200.1 4232.6 4342.4 4345.8 4396.1 4440.1 4440.2 4451.2 4489.5 4717.6 4719.6 4719.6 4723.3 4767.2 4722.4 4826.9 4843.0 4845.0 4949.7 4670.1 4720.3 4722.6 4725.9 4756.3 4846.6 4846.8 4859.6 4860.8 4907.2 4744.4 4828.6 4859.9 4860.3 4954.5 4731.4 4772.0 4777.2 4779.3 4818.6 4763.5 4773.6 4773.9 4775.1 4822.3 4490.1 4574.7 4617.0 4628.1 4760.9 4782.6 4818.8 4821.7 4825.1 4859.9 4733.1 4733.9 4734.8 4739.1 4765.4 11:00:13 INFO - PROCESS | 26246 | 11:00:13 INFO - PROCESS | 26246 | [#1] ext.html Cycles:180 Average:35810.33 Median:32438.51 stddev:55051.37 (169.7%) stddev-sans-first:55141.89 11:00:13 INFO - PROCESS | 26246 | Values: 479.4 490.7 505.3 510.2 510.4 26301.6 27090.5 32400.7 32837.2 32855.5 35968.3 36474.0 36480.5 36491.8 36558.8 7531.2 7739.1 7741.5 7746.7 7748.2 7429.0 7555.6 7558.3 7570.6 7571.1 7659.1 7737.6 7739.3 7780.7 7789.1 7682.4 7721.7 7747.3 7753.7 7755.0 7644.5 7742.9 7778.5 7781.5 7785.5 36009.3 36616.6 36839.0 36844.0 36877.3 2835.6 2895.3 2906.5 2944.5 2952.6 28248.6 28286.6 28321.7 28361.1 28436.9 3256.0 3306.7 3312.4 3344.5 3376.5 210967.0 211029.0 211655.0 212032.0 212688.0 45177.8 49813.5 50044.5 50062.7 50224.7 39898.4 40054.6 40125.8 40132.6 40148.4 13630.0 14183.4 14246.2 14312.9 14313.5 9968.6 10008.4 10019.4 10032.7 10036.1 15012.1 15540.3 17101.5 17347.3 18707.2 7286.6 7466.6 7602.9 7618.7 7690.2 840.9 847.9 894.2 912.1 922.9 25546.2 26072.7 26160.1 26445.9 26465.9 903.2 914.8 954.5 982.9 1053.4 12125.6 12292.1 12293.4 12296.1 12320.0 249194.0 254327.0 254769.0 254852.0 255772.0 43124.6 43316.6 43401.6 43428.8 43453.3 1222.9 1228.3 1233.4 1234.0 1235.4 22782.4 23450.4 23610.6 23657.5 23679.2 34623.1 34891.1 35418.8 36062.6 40100.0 158539.0 158588.0 159134.0 159699.0 159823.2 24792.3 25134.0 25145.7 25173.6 25200.0 29533.7 32186.8 35428.3 37320.5 37594.4 29782.1 29910.7 30617.0 31239.2 31440.7 30229.5 30248.8 30512.0 30560.8 30663.7 32083.0 32476.4 32501.0 32856.5 32940.2 26767.6 27918.3 31776.5 32249.0 32313.7 22066.6 22222.7 22456.0 22485.6 22539.8 11:00:13 INFO - PROCESS | 26246 | 11:00:13 INFO - PROCESS | 26246 | [#2] jquery.html Cycles:180 Average:21825.16 Median:5075.35 stddev:64631.82 (1273.4%) stddev-sans-first:64792.98 11:00:13 INFO - PROCESS | 26246 | Values: 333.2 334.4 334.7 341.1 341.1 11709.2 12152.3 14417.7 14655.0 15784.8 14138.2 14432.4 14669.6 15369.7 15466.5 4493.8 4778.5 5024.4 5711.2 5715.3 3687.7 3871.2 5565.6 5796.8 5797.7 5578.6 5652.2 5712.9 5713.4 5761.8 5613.8 5635.9 5644.9 5655.8 5690.0 4828.9 5067.9 5069.1 5072.9 5077.8 17766.8 17834.9 17923.6 18197.0 18207.1 1881.8 1904.1 1919.3 1997.4 2109.3 12158.2 12210.7 12257.2 12294.8 12354.6 1668.1 1679.4 1715.5 1723.8 1777.6 45924.8 45961.0 46672.1 47009.1 47104.8 9053.9 9117.4 9210.7 9225.4 9289.7 11818.6 11826.4 11830.8 11835.2 11843.9 7052.2 7056.2 7091.0 7098.5 7111.0 6796.0 6814.9 6850.3 6863.9 6865.5 4774.1 5047.7 5551.9 5575.9 5641.2 1586.4 1645.3 1651.5 1652.9 1669.3 895.3 916.4 917.8 961.9 975.7 11901.3 13755.6 14075.6 14992.3 15170.0 833.9 849.7 862.2 943.9 967.9 8583.0 9110.1 9146.7 9177.7 9308.3 394084.0 395185.0 396515.0 397205.0 399530.0 52867.7 52904.5 53378.0 54074.0 54833.2 1099.1 1106.0 1109.4 1119.3 1131.3 12668.2 13383.2 13428.3 13666.9 13808.1 27723.0 28532.3 30019.4 30463.2 30553.5 35396.5 35797.3 35962.5 36559.5 37544.2 6265.3 6400.5 6544.9 6616.4 6671.5 7972.7 8736.9 9476.8 9601.5 9603.4 7641.1 7736.1 7798.8 7824.3 7925.6 6739.9 7447.6 8067.6 8071.3 8329.8 7623.2 7679.7 7684.6 7767.9 7787.0 6133.5 6248.0 6362.7 6429.9 6465.6 7100.9 7799.3 7807.3 7860.4 7915.6 11:00:13 INFO - PROCESS | 26246 | 11:00:13 INFO - PROCESS | 26246 | [#3] mootools.html Cycles:180 Average:5305.44 Median:6551.44 stddev:2784.66 (42.5%) stddev-sans-first:2774.16 11:00:13 INFO - PROCESS | 26246 | Values: 1058.3 1383.8 1392.5 1521.6 1759.4 6310.6 7280.6 7454.1 7466.5 7467.3 7196.1 7365.2 7376.7 7382.0 7446.1 1835.4 1870.8 1885.4 2172.1 2203.9 1844.9 1852.2 2157.6 2209.7 2214.4 2135.5 2170.1 2175.8 2176.9 2177.3 2128.4 2153.5 2154.8 2156.6 2159.5 2106.4 2130.8 2135.2 2136.2 2137.8 7288.6 7322.7 7329.0 7348.5 7354.3 4421.9 4524.0 4531.1 4547.7 4548.6 2841.5 2886.8 2907.6 2912.3 2937.1 911.4 1680.5 1719.4 1732.1 1739.3 9804.1 9916.5 9923.5 9931.4 9958.2 3839.6 3841.4 3887.7 3906.8 3993.7 8064.2 8073.5 8091.8 8091.9 8098.4 4503.2 4506.1 4507.2 4512.7 4514.5 4074.0 4093.2 4101.4 4107.2 4107.9 3330.4 3353.3 3386.2 3388.7 3405.6 879.4 911.4 1029.0 1034.8 1035.3 907.0 928.1 931.6 942.5 1207.9 6944.1 6965.0 6971.4 6971.6 6977.5 1023.4 1030.2 1035.9 1046.5 1064.3 5540.0 5568.6 5647.6 5663.0 5673.0 9380.7 9577.3 9582.3 9711.1 9748.5 9378.9 9523.4 9596.1 9638.6 9646.8 7303.0 7431.0 7439.3 7443.9 7448.7 6921.5 7021.8 7055.2 7067.3 7078.2 8292.5 8327.8 8458.9 8549.7 8561.1 8546.3 8765.3 8786.9 8800.3 8819.9 6420.1 6543.9 6549.3 6549.9 6553.0 7236.0 7280.1 7328.3 7340.4 7346.3 6931.2 6985.7 7035.6 7098.3 7117.0 6887.4 6904.5 7015.2 7072.9 7096.1 7012.3 7122.2 7123.0 7125.8 7128.6 6431.4 6522.9 6541.2 6571.1 6583.7 6436.3 6523.5 6525.9 6528.3 6539.4 11:00:13 INFO - PROCESS | 26246 | 11:00:13 INFO - PROCESS | 26246 | [#4] prototype.html Cycles:180 Average:4617.66 Median:5251.53 stddev:1348.29 (25.7%) stddev-sans-first:1312.79 11:00:13 INFO - PROCESS | 26246 | Values: 312.9 317.2 318.8 322.8 330.6 5240.4 5268.3 5269.8 5280.8 5290.6 5231.2 5240.4 5250.9 5252.1 5260.6 3958.8 4041.4 4058.0 4131.7 4139.2 4124.5 4140.0 4151.2 4151.6 4152.9 4089.4 4145.8 4146.5 4151.4 4152.1 3906.8 4002.5 4025.5 4137.8 4165.8 3676.7 3684.2 3685.0 3688.6 3692.2 5044.5 5048.3 5048.7 5051.1 5058.4 4758.6 4767.5 4768.9 4774.9 4776.4 5301.3 5520.9 5521.7 5523.0 5546.1 3923.7 3924.4 3925.7 3926.1 3929.8 5737.4 5824.4 5825.1 5832.1 5840.6 4048.5 4058.1 4058.2 4059.3 4064.0 3827.8 3849.8 3866.9 3952.9 4105.9 4541.4 4543.6 4549.3 4551.6 4556.1 5384.4 5396.1 5526.3 5537.4 5592.6 1430.7 1454.2 1454.5 1454.6 1454.6 983.2 988.9 992.7 1009.3 1009.6 4901.2 4917.7 4918.2 4922.3 4923.9 5746.9 5749.2 5750.8 5763.4 5765.2 4899.6 4903.1 4903.2 4904.8 4908.4 2968.7 3030.3 3047.9 3057.8 3075.5 5517.6 5519.7 5521.9 5537.2 5543.2 5939.5 5952.1 5956.3 5964.9 5967.1 5397.2 5511.6 5517.4 5520.7 5524.9 5778.2 5792.1 5805.5 5811.7 5816.8 5676.3 5677.0 5678.9 5681.1 5684.3 5504.3 5520.0 5533.0 5537.7 5540.8 3900.6 4015.4 4021.8 4025.3 4038.3 5669.5 5706.1 5729.1 5761.8 5762.2 5525.3 5537.6 5538.1 5538.7 5540.8 5418.4 5529.6 5543.5 5549.8 5550.8 5417.7 5423.6 5427.7 5427.9 5428.8 5550.0 5566.5 5571.2 5571.9 5576.5 5435.9 5440.2 5449.9 5454.2 5456.7 11:00:13 INFO - PROCESS | 26246 | 11:00:13 INFO - PROCESS | 26246 | [#5] yui.html Cycles:180 Average:10978.76 Median:3296.06 stddev:12398.10 (376.1%) stddev-sans-first:12408.84 11:00:13 INFO - PROCESS | 26246 | Values: 696.6 703.4 712.4 719.1 745.1 10871.6 10891.2 11008.6 11031.1 11142.3 11449.1 11505.9 11519.7 11523.9 11524.5 619.2 628.3 784.3 792.4 802.7 801.4 805.6 808.3 808.9 809.4 846.9 848.8 849.0 849.2 849.5 640.7 650.0 816.2 830.7 831.9 613.7 615.6 615.9 616.0 616.1 10708.6 10726.5 10816.1 10817.4 10820.4 10598.6 10607.9 10754.8 10907.4 11145.0 8595.9 8706.7 8772.5 8811.9 9010.6 3108.2 3124.1 3143.7 3158.6 3180.0 37077.3 37247.8 37278.3 37534.4 37621.0 8619.7 8621.7 8721.9 8746.1 8750.1 14014.4 14061.5 14090.3 14091.2 14103.9 5978.4 6180.6 6212.9 6382.5 6537.2 3662.9 3693.5 3743.2 3755.6 3764.4 2717.3 2739.7 2743.5 2744.1 2750.8 510.4 512.2 523.1 529.9 531.0 436.6 446.3 552.7 553.5 555.6 6970.0 6991.9 7069.2 7119.2 7279.6 500.2 544.1 561.1 579.5 581.6 3319.1 3374.6 3383.2 3387.9 3504.4 44010.3 44768.6 44780.3 44802.0 44815.6 38779.3 39608.4 39709.2 40018.8 40059.8 36112.8 36306.8 36417.3 36607.1 36903.6 6684.1 6787.7 6806.1 6855.0 6866.6 28290.6 28419.9 28457.0 28866.9 28935.0 32455.2 34062.3 35363.6 36137.6 36452.3 8577.9 8601.5 8602.1 8653.7 8931.7 9048.0 9048.2 9157.9 9194.5 9284.7 8383.5 8622.4 8626.3 8702.6 8722.1 8579.9 8591.3 8612.6 8634.7 8644.1 8236.5 8311.1 8397.9 8428.8 8549.2 7420.7 7651.1 7744.7 7768.0 7800.9 7546.8 7619.8 7738.8 7801.3 7988.7 11:00:13 INFO - PROCESS | 26246 | -------- Summary: end -------- 11:00:13 INFO - PROCESS | 26246 | 11:00:14 INFO - TEST-INFO | 26246: exit 0 11:00:14 INFO - TEST-OK | dromaeo_css | took 1117123ms 11:00:14 INFO - TEST-START | kraken 11:00:14 INFO - operating with platform_type : linux_ 11:00:14 INFO - Initialising browser for kraken test... 11:00:14 INFO - TEST-INFO | started process 26442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRqpK3o/profile http://localhost:37170/getInfo.html) 11:00:18 INFO - PROCESS | 26442 | __metrics Screen width/height:1600/1200 11:00:18 INFO - PROCESS | 26442 | colorDepth:24 11:00:18 INFO - PROCESS | 26442 | Browser inner width/height: 1024/697 11:00:18 INFO - PROCESS | 26442 | __metrics 11:00:19 INFO - PROCESS | 26442 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:00:19 INFO - PROCESS | 26442 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:00:20 INFO - TEST-INFO | 26442: exit 0 11:00:20 INFO - Browser initialized. 11:00:20 INFO - Running cycle 1/1 for kraken test... 11:00:20 INFO - TEST-INFO | started process 26522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRqpK3o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:32 INFO - PROCESS | 26522 | RSS: Main: 149512192 11:00:32 INFO - PROCESS | 26522 | 11:00:34 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37170/tests/kraken/driver.html?testName=audio-beat-detection) 11:00:35 INFO - PROCESS | 26522 | RSS: Main: 188211200 11:00:35 INFO - PROCESS | 26522 | 11:00:38 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37170/tests/kraken/driver.html?testName=audio-dft) 11:00:38 INFO - PROCESS | 26522 | RSS: Main: 176340992 11:00:38 INFO - PROCESS | 26522 | 11:00:41 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37170/tests/kraken/driver.html?testName=audio-fft) 11:00:42 INFO - PROCESS | 26522 | RSS: Main: 161710080 11:00:42 INFO - PROCESS | 26522 | 11:00:44 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37170/tests/kraken/driver.html?testName=audio-oscillator) 11:00:45 INFO - PROCESS | 26522 | RSS: Main: 162213888 11:00:45 INFO - PROCESS | 26522 | 11:00:47 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37170/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:00:47 INFO - PROCESS | 26522 | RSS: Main: 163950592 11:00:47 INFO - PROCESS | 26522 | 11:00:50 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37170/tests/kraken/driver.html?testName=imaging-darkroom) 11:00:51 INFO - PROCESS | 26522 | RSS: Main: 166404096 11:00:51 INFO - PROCESS | 26522 | 11:00:54 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37170/tests/kraken/driver.html?testName=imaging-desaturate) 11:00:55 INFO - PROCESS | 26522 | RSS: Main: 164581376 11:00:55 INFO - PROCESS | 26522 | 11:00:58 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37170/tests/kraken/driver.html?testName=json-parse-financial) 11:00:58 INFO - PROCESS | 26522 | RSS: Main: 166633472 11:00:58 INFO - PROCESS | 26522 | 11:01:00 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37170/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:01:01 INFO - PROCESS | 26522 | RSS: Main: 177414144 11:01:01 INFO - PROCESS | 26522 | 11:01:03 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37170/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:01:03 INFO - PROCESS | 26522 | RSS: Main: 176476160 11:01:03 INFO - PROCESS | 26522 | 11:01:05 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37170/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:01:06 INFO - PROCESS | 26522 | RSS: Main: 183808000 11:01:06 INFO - PROCESS | 26522 | 11:01:08 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:01:09 INFO - PROCESS | 26522 | RSS: Main: 190345216 11:01:09 INFO - PROCESS | 26522 | 11:01:12 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:01:12 INFO - PROCESS | 26522 | RSS: Main: 188461056 11:01:12 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | Cycle 1(1): loaded http://localhost:37170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37170/tests/kraken/driver.html?testName=ai-astar) 11:01:14 INFO - PROCESS | 26522 | RSS: Main: 246353920 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | __start_tp_report 11:01:14 INFO - PROCESS | 26522 | _x_x_mozilla_page_load 11:01:14 INFO - PROCESS | 26522 | _x_x_mozilla_page_load_details 11:01:14 INFO - PROCESS | 26522 | |i|pagename|runs| 11:01:14 INFO - PROCESS | 26522 | |0;ai-astar;112;112;106;112;114;113;103;112;112;120 11:01:14 INFO - PROCESS | 26522 | |1;audio-beat-detection;163;132;155;166;129;152;156;139;177;139 11:01:14 INFO - PROCESS | 26522 | |2;audio-dft;161;161;161;160;161;158;161;161;162;161 11:01:14 INFO - PROCESS | 26522 | |3;audio-fft;72;72;86;94;74;73;74;104;87;73 11:01:14 INFO - PROCESS | 26522 | |4;audio-oscillator;97;97;138;96;98;98;136;98;98;131 11:01:14 INFO - PROCESS | 26522 | |5;imaging-gaussian-blur;109;110;110;109;109;109;109;110;110;109 11:01:14 INFO - PROCESS | 26522 | |6;imaging-darkroom;148;148;148;149;148;148;148;147;148;147 11:01:14 INFO - PROCESS | 26522 | |7;imaging-desaturate;95;95;95;96;95;96;96;95;95;95 11:01:14 INFO - PROCESS | 26522 | |8;json-parse-financial;70;71;71;70;70;71;71;80;69;69 11:01:14 INFO - PROCESS | 26522 | |9;json-stringify-tinderbox;66;67;67;67;67;68;68;68;67;67 11:01:14 INFO - PROCESS | 26522 | |10;stanford-crypto-aes;82;89;83;83;82;83;84;84;84;83 11:01:14 INFO - PROCESS | 26522 | |11;stanford-crypto-ccm;130;121;124;124;123;122;123;122;127;121 11:01:14 INFO - PROCESS | 26522 | |12;stanford-crypto-pbkdf2;138;148;147;150;148;136;149;146;147;137 11:01:14 INFO - PROCESS | 26522 | |13;stanford-crypto-sha256-iterative;72;71;72;71;71;70;71;70;72;72 11:01:14 INFO - PROCESS | 26522 | __end_tp_report 11:01:14 INFO - PROCESS | 26522 | __start_cc_report 11:01:14 INFO - PROCESS | 26522 | _x_x_mozilla_cycle_collect,991 11:01:14 INFO - PROCESS | 26522 | __end_cc_report 11:01:14 INFO - PROCESS | 26522 | __startTimestamp1452538874652__endTimestamp 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | ------- Summary: start ------- 11:01:14 INFO - PROCESS | 26522 | Number of tests: 14 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:4.53 (4.0%) stddev-sans-first:4.80 11:01:14 INFO - PROCESS | 26522 | Values: 112.0 112.0 106.0 112.0 114.0 113.0 103.0 112.0 112.0 120.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:155.50 stddev:15.70 (10.1%) stddev-sans-first:16.02 11:01:14 INFO - PROCESS | 26522 | Values: 163.0 132.0 155.0 166.0 129.0 152.0 156.0 139.0 177.0 139.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 11:01:14 INFO - PROCESS | 26522 | Values: 161.0 161.0 161.0 160.0 161.0 158.0 161.0 161.0 162.0 161.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.00 stddev:11.29 (15.3%) stddev-sans-first:11.50 11:01:14 INFO - PROCESS | 26522 | Values: 72.0 72.0 86.0 94.0 74.0 73.0 74.0 104.0 87.0 73.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:97.50 stddev:18.24 (18.7%) stddev-sans-first:18.85 11:01:14 INFO - PROCESS | 26522 | Values: 97.0 97.0 138.0 96.0 98.0 98.0 136.0 98.0 98.0 131.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:01:14 INFO - PROCESS | 26522 | Values: 109.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:01:14 INFO - PROCESS | 26522 | Values: 148.0 148.0 148.0 149.0 148.0 148.0 148.0 147.0 148.0 147.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:01:14 INFO - PROCESS | 26522 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:3.19 (4.5%) stddev-sans-first:3.35 11:01:14 INFO - PROCESS | 26522 | Values: 70.0 71.0 71.0 70.0 70.0 71.0 71.0 80.0 69.0 69.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 11:01:14 INFO - PROCESS | 26522 | Values: 66.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 67.0 67.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.50 stddev:2.00 (2.4%) stddev-sans-first:2.03 11:01:14 INFO - PROCESS | 26522 | Values: 82.0 89.0 83.0 83.0 82.0 83.0 84.0 84.0 84.0 83.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:123.50 stddev:2.83 (2.3%) stddev-sans-first:1.87 11:01:14 INFO - PROCESS | 26522 | Values: 130.0 121.0 124.0 124.0 123.0 122.0 123.0 122.0 127.0 121.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:147.50 stddev:5.38 (3.6%) stddev-sans-first:5.15 11:01:14 INFO - PROCESS | 26522 | Values: 138.0 148.0 147.0 150.0 148.0 136.0 149.0 146.0 147.0 137.0 11:01:14 INFO - PROCESS | 26522 | 11:01:14 INFO - PROCESS | 26522 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:0.79 (1.1%) stddev-sans-first:0.78 11:01:14 INFO - PROCESS | 26522 | Values: 72.0 71.0 72.0 71.0 71.0 70.0 71.0 70.0 72.0 72.0 11:01:14 INFO - PROCESS | 26522 | -------- Summary: end -------- 11:01:14 INFO - PROCESS | 26522 | 11:01:15 INFO - TEST-INFO | 26522: exit 0 11:01:15 INFO - TEST-OK | kraken | took 61016ms 11:01:15 INFO - TEST-START | v8_7 11:01:15 INFO - operating with platform_type : linux_ 11:01:15 INFO - Initialising browser for v8_7 test... 11:01:15 INFO - TEST-INFO | started process 26771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbSzUCe/profile http://localhost:37170/getInfo.html) 11:01:19 INFO - PROCESS | 26771 | __metrics Screen width/height:1600/1200 11:01:19 INFO - PROCESS | 26771 | colorDepth:24 11:01:19 INFO - PROCESS | 26771 | Browser inner width/height: 1024/697 11:01:19 INFO - PROCESS | 26771 | __metrics 11:01:20 INFO - PROCESS | 26771 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:01:20 INFO - PROCESS | 26771 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:01:21 INFO - TEST-INFO | 26771: exit 0 11:01:21 INFO - Browser initialized. 11:01:21 INFO - Running cycle 1/1 for v8_7 test... 11:01:21 INFO - TEST-INFO | started process 26854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbSzUCe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:33 INFO - PROCESS | 26854 | RSS: Main: 149041152 11:01:33 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | Cycle 1(1): loaded http://localhost:37170/tests/v8_7/run.html (next: http://localhost:37170/tests/v8_7/run.html) 11:01:55 INFO - PROCESS | 26854 | RSS: Main: 452149248 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | __start_tp_report 11:01:55 INFO - PROCESS | 26854 | _x_x_mozilla_page_load 11:01:55 INFO - PROCESS | 26854 | _x_x_mozilla_page_load_details 11:01:55 INFO - PROCESS | 26854 | |i|pagename|runs| 11:01:55 INFO - PROCESS | 26854 | |0;Richards;167.0843776106934 11:01:55 INFO - PROCESS | 26854 | |1;DeltaBlue;194.25019425019426 11:01:55 INFO - PROCESS | 26854 | |2;Encrypt;286.8617326448652 11:01:55 INFO - PROCESS | 26854 | |3;Decrypt;5164.948453608247 11:01:55 INFO - PROCESS | 26854 | |4;RayTrace;1998.0039920159682 11:01:55 INFO - PROCESS | 26854 | |5;Earley;807.1025020177563 11:01:55 INFO - PROCESS | 26854 | |6;Boyer;12370.37037037037 11:01:55 INFO - PROCESS | 26854 | |7;RegExp;45177.77777777778 11:01:55 INFO - PROCESS | 26854 | |8;Splay;682.1282401091405 11:01:55 INFO - PROCESS | 26854 | |9;NavierStokes;4830.917874396136 11:01:55 INFO - PROCESS | 26854 | __end_tp_report 11:01:55 INFO - PROCESS | 26854 | __startTimestamp1452538915900__endTimestamp 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | ------- Summary: start ------- 11:01:55 INFO - PROCESS | 26854 | Number of tests: 10 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 167.1 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#1] DeltaBlue Cycles:1 Average:194.25 Median:194.25 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 194.3 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#2] Encrypt Cycles:1 Average:286.86 Median:286.86 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 286.9 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 5164.9 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 1998.0 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#5] Earley Cycles:1 Average:807.10 Median:807.10 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 807.1 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 12370.4 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#7] RegExp Cycles:1 Average:45177.78 Median:45177.78 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 45177.8 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#8] Splay Cycles:1 Average:682.13 Median:682.13 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 682.1 11:01:55 INFO - PROCESS | 26854 | 11:01:55 INFO - PROCESS | 26854 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:01:55 INFO - PROCESS | 26854 | Values: 4830.9 11:01:55 INFO - PROCESS | 26854 | -------- Summary: end -------- 11:01:55 INFO - PROCESS | 26854 | 11:01:56 INFO - TEST-INFO | 26854: exit 0 11:01:56 INFO - TEST-OK | v8_7 | took 41195ms 11:01:56 INFO - SUITE-END | took 1219s 11:01:56 INFO - Completed test suite (00:20:19) 11:01:56 INFO - Working with test: dromaeo_css 11:01:56 INFO - Generating results file: dromaeo_css 11:01:56 INFO - Working with test: kraken 11:01:56 INFO - Generating results file: kraken 11:01:56 INFO - javascript benchmark 11:01:56 INFO - Working with test: v8_7 11:01:56 INFO - Generating results file: v8_7 11:01:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:01:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:01:56 INFO - process_Request line: dromaeo_css 6068.44 graph.html#tests=[[72,132,35]] 11:01:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:01:56 INFO - process_Request line: kraken 1526.90 graph.html#tests=[[232,132,35]] 11:01:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:01:57 INFO - process_Request line: v8_7 18394.46 graph.html#tests=[[230,132,35]] 11:01:57 INFO - RETURN: dromaeo_css: 6068.44 11:01:57 INFO - RETURN: kraken: 1526.90 11:01:57 INFO - RETURN: v8_7: 18394.46 11:01:57 INFO - javascript benchmark 11:01:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2571.237644993667, 2634.7101818799943, 2643.7884969202464, 2656.1102030819675, 2663.5871439926814, 4338.284183109783, 4436.935135567464, 4449.911001779967, 4462.397576327195, 4483.977580112099, 4510.97744511277, 4558.635309175266, 4615.492295847454, 4617.399738034051, 4649.558291962267, 4182.414461975326, 4199.895002624929, 4261.2329780639475, 4295.720778149426, 4320.6327462165755, 4270.132974749736, 4276.016516201275, 4322.502912165094, 4324.22164010478, 4378.036831896993, 4090.325096359097, 4126.0, 4184.979075104636, 4189.853355132586, 4215.45199124115, 4223.113146239293, 4233.534311225793, 4247.91504169918, 4261.808218630169, 4279.636230920375, 4207.936880946758, 4212.85255016076, 4230.78846057699, 4256.404103425523, 4261.616454519108, 4299.441072660566, 4386.254336762758, 4418.270985287424, 4496.7077139985795, 4496.707713998612, 4916.041371932474, 4946.87632809179, 4954.063498551869, 4959.950400495985, 4994.525520075587, 4967.329410529568, 4967.453580106186, 4975.651704380694, 4978.079055374767, 4978.701277923336, 4393.736375817429, 4499.797509112131, 4500.8649740507835, 4510.436195475566, 4610.170169369479, 5017.523335283142, 5019.0463811875625, 5025.346704928336, 5043.0, 5045.344105266292, 4813.879653008633, 4822.638302127354, 4824.372831531879, 4825.975870120697, 4867.634927380461, 4686.0, 4795.976020119877, 4802.975985120122, 4905.779239934212, 4955.752212389366, 4800.5199480052415, 4867.70793752376, 4869.805207791719, 4878.048780487771, 4910.06708725341, 4804.399450068741, 4823.27650852375, 4826.7827947742435, 4833.492483289274, 4873.049755297683, 4026.798660066985, 4124.1957818225155, 4158.875233742992, 4161.354176485466, 4201.138766552849, 3594.6405359463843, 3620.5112309837837, 3688.889333320005, 3689.0408493791806, 3719.051641831316, 4268.658507319407, 4274.380214868826, 4284.271673815397, 4290.37789520524, 4315.201687687788, 4730.077634861169, 4934.506549345037, 4942.35749352589, 4943.332650092263, 4984.053029924376, 4192.832286708497, 4200.138971510833, 4232.6190642841675, 4342.392065110887, 4345.804438800262, 4396.098799746044, 4440.134173836135, 4440.245158323093, 4451.221036318696, 4489.483709373399, 4717.646176536773, 4719.646026547954, 4719.646026548091, 4723.338732577373, 4767.213409787346, 4722.409698787652, 4826.927596085991, 4843.0, 4845.0, 4949.653524253267, 4670.065986802721, 4720.291956206596, 4722.645801564965, 4725.905481890274, 4756.262779269219, 4846.588040016638, 4846.757662116951, 4859.562639362474, 4860.805567777249, 4907.214845624683, 4744.4069491313585, 4828.589569886599, 4859.878503037452, 4860.343853579863, 4954.529319714621, 4731.384919960383, 4772.0, 4777.163996300703, 4779.283107533898, 4818.590419814355, 4763.54746299101, 4773.64197685182, 4773.928391074067, 4775.068861572099, 4822.276658501253, 4490.101979604157, 4574.748388838646, 4616.953830461653, 4628.074385122922, 4760.9285860711425, 4782.569568738831, 4818.831340903192, 4821.710697358029, 4825.059113472979, 4859.878503037452, 4733.077049975222, 4733.881652958704, 4734.7632618369635, 4739.052189562032, 4765.380500534909], "unit": "score", "name": "dojo.html", "value": 4503.329373796217}, {"lowerIsBetter": false, "replicates": [479.3887793063843, 490.7104808163183, 505.2875445621673, 510.1607855078396, 510.3747908811704, 26301.60547591785, 27090.458190836198, 32400.67599324009, 32837.17907052325, 32855.507167392505, 35968.280634387294, 36474.0, 36480.452793208126, 36491.81754091232, 36558.81720591393, 7531.171571127172, 7739.110002349717, 7741.458097933147, 7746.651400686983, 7748.2251774822635, 7428.962855185743, 7555.622218889061, 7558.319751222389, 7570.583617901013, 7571.053618297713, 7659.119201291839, 7737.57443340616, 7739.342155916754, 7780.727674531393, 7789.065312162548, 7682.423818213629, 7721.652525636304, 7747.302742753123, 7753.689852405897, 7755.030621172354, 7644.503107298064, 7742.922570774276, 7778.494397864178, 7781.5331080135375, 7785.532868027936, 36009.27981440356, 36616.63383366159, 36839.0, 36844.0, 36877.26245475102, 2835.5888396182645, 2895.3340731631633, 2906.5058939980254, 2944.469995400827, 2952.601398811176, 28248.576271355945, 28286.575701364494, 28321.716782832114, 28361.14916552486, 28436.857815710788, 3256.0, 3306.6751760036705, 3312.420326442863, 3344.48160535115, 3376.5104059911178, 210967.0, 211029.0, 211655.0, 212031.99999999846, 212688.0, 45177.774111129234, 49813.50186498161, 50044.49955500471, 50062.749686252064, 50224.748876255384, 39898.40152397716, 40054.59945400567, 40125.799371002955, 40132.59867401347, 40148.397774033416, 13630.0, 14183.439821619613, 14246.216458094905, 14312.928435357757, 14313.499027533986, 9968.601255949681, 10008.399496030115, 10019.448930308758, 10032.69901902944, 10036.146927511243, 15012.099274043592, 15540.300686469136, 17101.520279559394, 17347.3061077558, 18707.193920911974, 7286.599237041907, 7466.589337586485, 7602.885956710654, 7618.733344332922, 7690.232325755684, 840.8948881389827, 847.8643417053241, 894.181823631383, 912.1380295620708, 922.9030951750104, 25546.23361299164, 26072.739272607032, 26160.084397046012, 26445.867770661025, 26465.867670661522, 903.1645727701849, 914.7895983923735, 954.4511905654276, 982.8771403574553, 1053.4469403563191, 12125.636230913087, 12292.078094142797, 12293.446794894073, 12296.139270251175, 12320.0, 249194.0, 254327.0, 254769.0, 254852.0, 255772.0, 43124.568754312684, 43316.56683433188, 43401.565984340385, 43428.78285608615, 43453.34819977703, 1222.908281878845, 1228.336698182971, 1233.3586535001748, 1233.9876601233873, 1235.4131787400913, 22782.430439239153, 23450.413739656644, 23610.645840312754, 23657.52684946257, 23679.171229007592, 34623.13442163966, 34891.127721806144, 35418.8229058853, 36062.63937360698, 40100.0, 158539.0, 158588.0, 159134.0, 159699.0, 159823.20088399484, 24792.25623231306, 25134.0, 25145.748542514342, 25173.622395664446, 25199.992000320515, 29533.704662953096, 32186.83906580452, 35428.29143417169, 37320.45938408944, 37594.43608345932, 29782.10653680393, 29910.70089299079, 30617.0, 31239.219019524695, 31440.685593143775, 30229.546556801226, 30248.84875575608, 30512.0, 30560.84719576388, 30663.693363066082, 32083.0, 32476.350472990882, 32501.0, 32856.50715239225, 32940.1764955878, 26767.598486022336, 27918.30204244829, 31776.523352149274, 32249.0, 32313.676863232005, 22066.558668826856, 22222.666659999788, 22456.0, 22485.5502889938, 22539.774602254423], "unit": "score", "name": "ext.html", "value": 15637.099308465407}, {"lowerIsBetter": false, "replicates": [333.15266845342575, 334.3830632483069, 334.7071312601473, 341.09949732705644, 341.13862497194594, 11709.180357374988, 12152.27086374816, 14417.711645767078, 14654.954091538833, 15784.842151578496, 14138.151710897353, 14432.42270309189, 14669.559913202595, 15369.692606147899, 15466.458673946414, 4493.820247190125, 4778.498257682945, 5024.422191447976, 5711.228984087136, 5715.3141623005085, 3687.668109870111, 3871.2451072040963, 5565.6104072714725, 5796.82609521715, 5797.681127537984, 5578.553715702734, 5652.236803383774, 5712.8857422851515, 5713.400092990239, 5761.769529218826, 5613.775448982035, 5635.887282254373, 5644.887102257973, 5655.773769049233, 5690.032694441934, 4828.879278018043, 5067.923981140286, 5069.138246498104, 5072.923906141411, 5077.771500282496, 17766.822331776777, 17834.91082544592, 17923.641527169384, 18197.0, 18207.08964551767, 1881.840043596296, 1904.076522886399, 1919.3090487424515, 1997.3508609701905, 2109.34610270815, 12158.209716368408, 12210.694732631666, 12257.203281786744, 12294.75410491785, 12354.567590134302, 1668.0658831054648, 1679.3702361614394, 1715.468204856486, 1723.7931448226168, 1777.6355847051323, 45924.770376147906, 45961.0, 46672.06655866898, 47009.05981880378, 47104.76447617774, 9053.864192037125, 9117.361784675142, 9210.677626283183, 9225.446473211628, 9289.674861379819, 11818.586349477728, 11826.408679565988, 11830.822537661941, 11835.230710003994, 11843.940780296043, 7052.188998265163, 7056.15326160864, 7091.0, 7098.503104782616, 7111.040009598742, 6795.966020169966, 6814.93185068143, 6850.314968503109, 6863.931360686429, 6865.485088618374, 4774.092922344744, 5047.697138171721, 5551.916721249185, 5575.916361254584, 5641.2384328116, 1586.4050980882168, 1645.3418632547077, 1651.5210588929317, 1652.8760342974324, 1669.2655231698013, 895.3463971300987, 916.4409710076848, 917.7522069041455, 961.9466683981029, 975.6823083215644, 11901.345426001653, 13755.587332380044, 14075.648108797363, 14992.250387480583, 15170.0, 833.9416240863081, 849.7323343146888, 862.1895418306772, 943.8631398447324, 967.874176357069, 8582.957085214533, 9110.134537218953, 9146.661468563927, 9177.678781242625, 9308.255339572954, 394084.0, 395185.0, 396515.0, 397205.0, 399530.0, 52867.73566132145, 52904.47095529072, 53378.0, 54074.0, 54833.177502337494, 1099.1261946752352, 1106.0377471599759, 1109.367660433545, 1119.2948442481347, 1131.2759833706434, 12668.239905605693, 13383.19700817954, 13428.328583570586, 13666.863331366956, 13808.1024733392, 27723.0, 28532.286692832844, 30019.3996120072, 30463.238419039702, 30553.54169687501, 35396.46905296474, 35797.28405431929, 35962.46056309105, 36559.45160822643, 37544.249115018094, 6265.27949285838, 6400.51996100285, 6544.934550654432, 6616.4045235929, 6671.532992690659, 7972.681092756225, 8736.868946965673, 9476.763080923032, 9601.519924003911, 9603.37578057424, 7641.083070031409, 7736.071671399468, 7798.844023119619, 7824.334931530883, 7925.603719813871, 6739.865202696017, 7447.590382528796, 8067.636956336862, 8071.273585377344, 8329.750107496784, 7623.16145224036, 7679.654415551426, 7684.5773482459, 7767.883481747665, 7786.961065194638, 6133.53998450127, 6247.969085100907, 6362.6818659067785, 6429.935700642934, 6465.579737317059, 7100.857982840417, 7799.298063174341, 7807.258310460497, 7860.449768516149, 7915.564643944638], "unit": "score", "name": "jquery.html", "value": 7417.187940384011}, {"lowerIsBetter": false, "replicates": [1058.2645061682124, 1383.8339399272086, 1392.456941792701, 1521.5815650696056, 1759.3578343904471, 6310.558260921737, 7280.635968201588, 7454.142773581039, 7466.51467654602, 7467.253274672544, 7196.064511613483, 7365.15300740415, 7376.74181403651, 7382.0, 7446.069241344832, 1835.3851459760997, 1870.7848597411337, 1885.3778253176488, 2172.1094351315965, 2203.911843526257, 1844.8985305808176, 1852.21280955594, 2157.611629906616, 2209.6795964585126, 2214.4353189936623, 2135.4661334666334, 2170.0885628036262, 2175.8041776240134, 2176.8789073627095, 2177.3032629558547, 2128.4040468668795, 2153.547754971458, 2154.762976072631, 2156.5902478529188, 2159.5356998245375, 2106.441792924876, 2130.8295336373053, 2135.16728475893, 2136.2309568555306, 2137.754158271803, 7288.56268623879, 7322.670479828367, 7329.0, 7348.485606007582, 7354.30850904295, 4421.889452763675, 4523.954760452386, 4531.093781243764, 4547.7271363717955, 4548.613367863735, 2841.4743272494657, 2886.841223732694, 2907.6220091387986, 2912.286489809989, 2937.104183224116, 911.4166933162782, 1680.5126513311125, 1719.3982106262708, 1732.1252767352532, 1739.2781995471864, 9804.068613481708, 9916.504174791231, 9923.503824808731, 9931.404115753077, 9958.203343732484, 3839.5968423315708, 3841.442990766379, 3887.727859049896, 3906.8437262509183, 3993.660538854172, 8064.153263907206, 8073.515589064557, 8091.838163236703, 8091.87862182056, 8098.433109682265, 4503.166914120898, 4506.076254367847, 4507.233770259064, 4512.661550383735, 4514.503404625489, 4073.9796301018305, 4093.1609020151395, 4101.446304748881, 4107.240160570304, 4107.856225032109, 3330.4338262495435, 3353.312570922955, 3386.1873150443716, 3388.711959483422, 3405.5743032120986, 879.445949052093, 911.3939230411702, 1028.99485502572, 1034.7671773850973, 1035.2597892506744, 907.0249481807084, 928.1414691410419, 931.6413180925392, 942.4769253064615, 1207.8671346151916, 6944.097267355312, 6964.965175174092, 6971.407430368476, 6971.616561089088, 6977.476689248327, 1023.3655133817081, 1030.1964467715195, 1035.9326643768131, 1046.4663021858908, 1064.292245656645, 5540.0, 5568.582356323292, 5647.632903861236, 5663.008973429633, 5673.0, 9380.67167649129, 9577.329586928987, 9582.28132890036, 9711.125998660013, 9748.463834489172, 9378.920169726054, 9523.428594284227, 9596.088371604686, 9638.566264518113, 9646.758831029281, 7302.96348518254, 7431.033965584439, 7439.293267139613, 7443.925560744323, 7448.702051917862, 6921.48088893325, 7021.754238601625, 7055.223925368308, 7067.293270672892, 7078.18600860887, 8292.460990035628, 8327.750167494985, 8458.873116903374, 8549.743507694779, 8561.10108438605, 8546.316294696286, 8765.254953329038, 8786.912130878609, 8800.251978581893, 8819.91180088191, 6420.133282007057, 6543.901841472287, 6549.345065493603, 6549.8690026200165, 6553.0170474429215, 7235.963820180866, 7280.126384833854, 7328.3404493595835, 7340.449466290156, 7346.302101300368, 6931.2375638678695, 6985.650717464005, 7035.648217589202, 7098.3256590623805, 7117.039199707973, 6887.449004079762, 6904.482163837632, 7015.193252775996, 7072.929270707227, 7096.077509923677, 7012.298770122947, 7122.21655617892, 7123.0, 7125.786226413215, 7128.572285662877, 6431.421172094347, 6522.934770652233, 6541.182352205974, 6571.080048793077, 6583.670816459254, 6436.324185960594, 6523.510736694861, 6525.9021114684265, 6528.314526974599, 6539.411452969255], "unit": "score", "name": "mootools.html", "value": 4337.223405204128}, {"lowerIsBetter": false, "replicates": [312.87015888406313, 317.19907234233574, 318.813494105948, 322.7982510930668, 330.55210190192287, 5240.449752775956, 5268.341457317835, 5269.8155564555245, 5280.762365693538, 5290.550303224221, 5231.163013917774, 5240.449752775951, 5250.921236181461, 5252.133397989327, 5260.579153667707, 3958.8218530166214, 4041.3937909313545, 4058.0, 4131.710780245384, 4139.172165566891, 4124.546299907008, 4140.0, 4151.2112698587325, 4151.588459923625, 4152.875413737577, 4089.4274801527663, 4145.7719825409595, 4146.481689788777, 4151.418801367796, 4152.0657851983215, 3906.824192911326, 4002.4596679448337, 4025.4565633639377, 4137.81379837905, 4165.75005499671, 3676.6874815640704, 3684.207895302496, 3684.9631503684886, 3688.5942546319884, 3692.2430901665093, 5044.470330615306, 5048.3184770056305, 5048.747562621854, 5051.1413059779925, 5058.367704036996, 4758.571728544413, 4767.451743049559, 4768.904621907543, 4774.928376074362, 4776.355192049098, 5301.3373328333955, 5520.91718624221, 5521.723913804334, 5522.950639378505, 5546.112621980464, 3923.7253392262555, 3924.4113382992496, 3925.685945124383, 3926.0773718176206, 3929.8231579578987, 5737.3975732548315, 5824.417558244184, 5825.097109947965, 5832.12518122285, 5840.561957853178, 4048.4939382577177, 4058.1477889643506, 4058.2086493133556, 4059.330210515291, 4063.9796801015805, 3827.7894715790344, 3849.8075096245075, 3866.9226615468096, 3952.9011774705864, 4105.876823695294, 4541.3869127668, 4543.61379282758, 4549.340345649863, 4551.613112885442, 4556.11155824611, 5384.434634363413, 5396.1366181410785, 5526.281583394213, 5537.390887002426, 5592.608517403824, 1430.7281616492833, 1454.1783892101141, 1454.5418193269086, 1454.5709015840353, 1454.6217983324411, 983.1692220074026, 988.906053924876, 992.7220378294089, 1009.28340877976, 1009.601207523039, 4901.166801643729, 4917.704937703749, 4918.163912134945, 4922.286268491049, 4923.90152196954, 5746.913796293059, 5749.195112684228, 5750.7987220447085, 5763.423657634203, 5765.221695071112, 4899.583535399531, 4903.141950158708, 4903.215485522299, 4904.779284932187, 4908.361912951294, 2968.732814046746, 3030.3030303030428, 3047.9085627431214, 3057.770667199969, 3075.4925437302595, 5517.586181036439, 5519.69641669712, 5521.917171242435, 5537.224788529609, 5543.168524721244, 5939.4951429129005, 5952.136940143741, 5956.285245770535, 5964.940350596438, 5967.1347654589845, 5397.2443857859935, 5511.559075273888, 5517.393086760453, 5520.696361700065, 5524.917126243109, 5778.191053252464, 5792.102224155263, 5805.506531944832, 5811.709414529341, 5816.76732930678, 5676.262085928803, 5676.971615141898, 5678.858028549319, 5681.0910254359105, 5684.346300175533, 5504.311961004874, 5520.033994050945, 5532.972335138298, 5537.723113844372, 5540.806071787468, 3900.6294402031763, 4015.4177644242004, 4021.819018144249, 4025.295573274607, 4038.293298672662, 5669.518090962314, 5706.144078388109, 5729.140628905698, 5761.769529218785, 5762.193292938908, 5525.336959564878, 5537.612367134262, 5538.0585300499815, 5538.723063846872, 5540.833774986757, 5418.431064738145, 5529.612927095226, 5543.473370029841, 5549.805756798492, 5550.75021624036, 5417.729113544228, 5423.647462914898, 5427.674339539641, 5427.945720542902, 5428.809991650273, 5550.0, 5566.526845218202, 5571.247881535941, 5571.9442805571425, 5576.498115169654, 5435.864103397446, 5440.156775699773, 5449.891002180014, 5454.154606036071, 5456.708182563412], "unit": "score", "name": "prototype.html", "value": 4191.949056018598}, {"lowerIsBetter": false, "replicates": [696.6029363262938, 703.4161645833958, 712.3873468816819, 719.0759873562473, 745.0686641697874, 10871.619493317736, 10891.183161262898, 11008.559657613705, 11031.062359699425, 11142.27575207611, 11449.141314401411, 11505.942470287659, 11519.712007199823, 11523.884761152385, 11524.539018439253, 619.1610367951429, 628.2680677011276, 784.30588928798, 792.4294507954293, 802.7070119406433, 801.3669201330941, 805.5931754463987, 808.3452403553111, 808.8624933761246, 809.4010432280129, 846.8856704344896, 848.8005318750089, 849.0151424347758, 849.1593322610632, 849.5072857742525, 640.7308930249307, 649.9902501462482, 816.244973399609, 830.6511265268541, 831.9001719793603, 613.7483631710977, 615.6398506873485, 615.9414855588711, 615.989776766104, 616.0820377637333, 10708.625198118028, 10726.517306721216, 10816.080633146192, 10817.405042722647, 10820.350778953289, 10598.62904798336, 10607.946960265226, 10754.838677419766, 10907.400092994882, 11145.0, 8595.871061934076, 8706.6517339307, 8772.473651580925, 8811.94256689195, 9010.59452324647, 3108.1763332716846, 3124.078396872905, 3143.685631436861, 3158.6209654841564, 3179.998300535324, 37077.25845483075, 37247.81376093129, 37278.25443491142, 37534.436983445274, 37621.0, 8619.655213791504, 8621.741347759576, 8721.869171962426, 8746.081661425585, 8750.081241469681, 14014.439422423193, 14061.507847225297, 14090.295485225697, 14091.154530728189, 14103.85896141046, 5978.372270911578, 6180.629162250189, 6212.937870621236, 6382.521310901701, 6537.248216455074, 3662.9450558241647, 3693.4829123922673, 3743.232637309345, 3755.6244375562223, 3764.435334699817, 2717.30708669292, 2739.657542807149, 2743.478739039576, 2744.108164846393, 2750.7936904732223, 510.3951817096752, 512.1728408620052, 523.1237676891268, 529.8781280305551, 531.0, 436.6005105328589, 446.31071394770635, 552.6987791653559, 553.5239693863274, 555.5694336888944, 6969.965150174318, 6991.89512157318, 7069.222385537587, 7119.21688614252, 7279.6360181990685, 500.2321436594809, 544.1076634319719, 561.0602241245979, 579.5218944370911, 581.6306645280193, 3319.0872510059444, 3374.645662205482, 3383.1711230748624, 3387.9491807622903, 3504.404251277289, 44010.33984490235, 44768.55231447644, 44780.3282950756, 44802.0, 44815.55184448114, 38779.321157168255, 39608.405873911914, 39709.20581588352, 40018.799906000284, 40059.799701001306, 36112.81943590265, 36306.818465907505, 36417.27165456729, 36607.08482287964, 36903.63096369056, 6684.097646817618, 6787.66061696923, 6806.149231346082, 6854.971754236705, 6866.622335771581, 28290.57564136581, 28419.857900710365, 28457.00400486056, 28866.855665721538, 28935.0, 32455.188620284684, 34062.31875362528, 35363.646363536034, 36137.63862361343, 36452.27095458129, 8577.871331930151, 8601.483910965362, 8602.096779838026, 8653.740387788377, 8931.687390941286, 9048.039789931327, 9048.230900373543, 9157.86263206039, 9194.49430281341, 9284.72145835626, 8383.455075420079, 8622.353323500887, 8626.266767324847, 8702.56487175626, 8722.08418116114, 8579.871301930601, 8591.269742071994, 8612.61243244043, 8634.740957771277, 8644.135586441556, 8236.464629799044, 8311.085780564254, 8397.874031889649, 8428.819965204999, 8549.187827156411, 7420.703171873281, 7651.081870175614, 7744.65149068282, 7768.0, 7800.92199078002, 7546.773596792105, 7619.818928066159, 7738.806529836799, 7801.258880406353, 7988.720394786154], "unit": "score", "name": "yui.html", "value": 5258.543612769634}], "name": "dromaeo_css", "value": 6068.439449122511}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 106.0, 112.0, 114.0, 113.0, 103.0, 112.0, 112.0, 120.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [163.0, 132.0, 155.0, 166.0, 129.0, 152.0, 156.0, 139.0, 177.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 158.0, 161.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 86.0, 94.0, 74.0, 73.0, 74.0, 104.0, 87.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 138.0, 96.0, 98.0, 98.0, 136.0, 98.0, 98.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 70.0, 70.0, 71.0, 71.0, 80.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [82.0, 89.0, 83.0, 83.0, 82.0, 83.0, 84.0, 84.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [130.0, 121.0, 124.0, 124.0, 123.0, 122.0, 123.0, 122.0, 127.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [138.0, 148.0, 147.0, 150.0, 148.0, 136.0, 149.0, 146.0, 147.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 71.0, 71.0, 70.0, 71.0, 70.0, 72.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1526.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [194.25019425019426], "unit": "score", "name": "DeltaBlue", "value": 340.37546399999997}, {"lowerIsBetter": false, "replicates": [286.8617326448652], "unit": "score", "name": "Encrypt", "value": 927.906966}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [807.1025020177563], "unit": "score", "name": "Earley", "value": 825.7476570000002}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [45177.77777777778], "unit": "score", "name": "RegExp", "value": 20.164449090014738}, {"lowerIsBetter": false, "replicates": [682.1282401091405], "unit": "score", "name": "Splay", "value": 119.46580599999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18394.457171489757}]} 11:01:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "18394.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1526.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6068.44"}}} 11:01:57 INFO - Return code: 0 11:01:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:01:57 INFO - # TBPL SUCCESS # 11:01:57 INFO - Running post-action listener: _resource_record_post_action 11:01:57 INFO - Running post-run listener: _resource_record_post_run 11:01:58 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540278784; Read time: 12; Write time: 492308 11:01:58 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 230924288; Read time: 0; Write time: 267988 11:01:58 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308346880; Read time: 12; Write time: 224252 11:01:58 INFO - Running post-run listener: _upload_blobber_files 11:01:58 INFO - Blob upload gear active. 11:01:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:01:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:01:58 INFO - (blobuploader) - INFO - Open directory for files ... 11:01:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:01:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:01:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:01:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:01:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:01:59 INFO - (blobuploader) - INFO - Done attempting. 11:01:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:01:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:01:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:02:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:00 INFO - (blobuploader) - INFO - Done attempting. 11:02:00 INFO - (blobuploader) - INFO - Iteration through files over. 11:02:00 INFO - Return code: 0 11:02:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:02:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:02:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96c071789dceeca401b197c9e4e1a057f3e0b55af6baa83a3fc8b61e11fd9f7b1ddce51a94fa7c6867db56e97c7d6efc53bc0ae48a94f838d75cab522e0ccbba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d05564df5993f47b980a43056b279827b3cbf6f954d774d03d85845eead2c295684bbc8ff6708034b6966a27003e33dbd6c541d9fb15c6ba811b64df68b335ae"} 11:02:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:02:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:02:00 INFO - Contents: 11:02:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96c071789dceeca401b197c9e4e1a057f3e0b55af6baa83a3fc8b61e11fd9f7b1ddce51a94fa7c6867db56e97c7d6efc53bc0ae48a94f838d75cab522e0ccbba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d05564df5993f47b980a43056b279827b3cbf6f954d774d03d85845eead2c295684bbc8ff6708034b6966a27003e33dbd6c541d9fb15c6ba811b64df68b335ae"} 11:02:00 INFO - Copying logs to upload dir... 11:02:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1289.679570 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-11 11:02:00.549339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 11:02:00.557230) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96c071789dceeca401b197c9e4e1a057f3e0b55af6baa83a3fc8b61e11fd9f7b1ddce51a94fa7c6867db56e97c7d6efc53bc0ae48a94f838d75cab522e0ccbba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d05564df5993f47b980a43056b279827b3cbf6f954d774d03d85845eead2c295684bbc8ff6708034b6966a27003e33dbd6c541d9fb15c6ba811b64df68b335ae"} build_url:https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011126 build_url: 'https://queue.taskcluster.net/v1/task/aC7VeUkwRmCCJYBBxfJ-0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96c071789dceeca401b197c9e4e1a057f3e0b55af6baa83a3fc8b61e11fd9f7b1ddce51a94fa7c6867db56e97c7d6efc53bc0ae48a94f838d75cab522e0ccbba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d05564df5993f47b980a43056b279827b3cbf6f954d774d03d85845eead2c295684bbc8ff6708034b6966a27003e33dbd6c541d9fb15c6ba811b64df68b335ae"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 11:02:00.595050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 11:02:00.595677) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452535519.668463-499831196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 11:02:00.650420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 11:02:00.653835) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 11:02:00.654215) ========= ========= Total master_lag: 0.29 =========