builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1452373850.37 results: success (0) buildid: 20160109115632 builduid: 1259cee714494a73aba5290aa709a4c1 revision: c33f30666b37dbceffb9fbe5089a668db8893a85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.366463) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.366995) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.367306) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006217 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.436810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.437222) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.471354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.471749) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026201 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.522442) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.522972) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.523512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.523938) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 13:10:51-- 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% 83.2M=0s 2016-01-09 13:10:51 (83.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.228487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.767000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.767316) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.167141 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.946738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:50.947189) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c33f30666b37dbceffb9fbe5089a668db8893a85 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c33f30666b37dbceffb9fbe5089a668db8893a85 --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=97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 13:10:51,636 truncating revision to first 12 chars 2016-01-09 13:10:51,636 Setting DEBUG logging. 2016-01-09 13:10:51,636 attempt 1/10 2016-01-09 13:10:51,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c33f30666b37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 13:10:51,875 unpacking tar archive at: mozilla-central-c33f30666b37/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:51.491148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:51.491742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:51.503292) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:51.503927) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 13:10:51.504678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-01-09 13:10:51.505206) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:10:52 INFO - MultiFileLogger online at 20160109 13:10:52 in /builds/slave/test 13:10:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:10:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:10:52 INFO - {'append_to_log': False, 13:10:52 INFO - 'base_work_dir': '/builds/slave/test', 13:10:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:10:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:10:52 INFO - 'branch': 'Firefox-Non-PGO', 13:10:52 INFO - 'buildbot_json_path': 'buildprops.json', 13:10:52 INFO - 'config_files': ('talos/linux_config.py',), 13:10:52 INFO - 'default_actions': ('clobber', 13:10:52 INFO - 'read-buildbot-config', 13:10:52 INFO - 'download-and-extract', 13:10:52 INFO - 'populate-webroot', 13:10:52 INFO - 'create-virtualenv', 13:10:52 INFO - 'install', 13:10:52 INFO - 'run-tests'), 13:10:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:10:52 INFO - 'download_minidump_stackwalk': True, 13:10:52 INFO - 'download_symbols': 'ondemand', 13:10:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:10:52 INFO - 'tooltool.py': '/tools/tooltool.py', 13:10:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:10:52 INFO - '/tools/misc-python/virtualenv.py')}, 13:10:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:10:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:10:52 INFO - 'installer_path': 'installer.exe', 13:10:52 INFO - 'log_level': 'info', 13:10:52 INFO - 'log_name': 'talos', 13:10:52 INFO - 'log_to_console': True, 13:10:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:10:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:10:52 INFO - 'opt_config_files': (), 13:10:52 INFO - 'pip_index': False, 13:10:52 INFO - 'sps_profile': False, 13:10:52 INFO - 'sps_profile_interval': 0, 13:10:52 INFO - 'suite': 'dromaeojs', 13:10:52 INFO - 'system_bits': '32', 13:10:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:10:52 INFO - 'title': 'talos-linux64-ix-068', 13:10:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:10:52 INFO - 'use_talos_json': True, 13:10:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:10:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:10:52 INFO - 'work_dir': 'build'} 13:10:52 INFO - ##### 13:10:52 INFO - ##### Running clobber step. 13:10:52 INFO - ##### 13:10:52 INFO - Running pre-action listener: _resource_record_pre_action 13:10:52 INFO - Running main action method: clobber 13:10:52 INFO - rmtree: /builds/slave/test/build 13:10:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:10:53 INFO - Running post-action listener: _resource_record_post_action 13:10:53 INFO - ##### 13:10:53 INFO - ##### Running read-buildbot-config step. 13:10:53 INFO - ##### 13:10:53 INFO - Running pre-action listener: _resource_record_pre_action 13:10:53 INFO - Running main action method: read_buildbot_config 13:10:53 INFO - Using buildbot properties: 13:10:53 INFO - { 13:10:53 INFO - "project": "", 13:10:53 INFO - "product": "firefox", 13:10:53 INFO - "script_repo_revision": "production", 13:10:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:10:53 INFO - "repository": "", 13:10:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 13:10:53 INFO - "buildid": "20160109115632", 13:10:53 INFO - "pgo_build": "False", 13:10:53 INFO - "basedir": "/builds/slave/test", 13:10:53 INFO - "buildnumber": 254, 13:10:53 INFO - "slavename": "talos-linux64-ix-068", 13:10:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:10:53 INFO - "platform": "ubuntu64_hw", 13:10:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:10:53 INFO - "branch": "mozilla-central", 13:10:53 INFO - "repo_path": "mozilla-central", 13:10:53 INFO - "revision": "c33f30666b37dbceffb9fbe5089a668db8893a85", 13:10:53 INFO - "stage_platform": "linux64", 13:10:53 INFO - "builduid": "1259cee714494a73aba5290aa709a4c1", 13:10:53 INFO - "slavebuilddir": "test" 13:10:53 INFO - } 13:10:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:10:53 INFO - Running post-action listener: _resource_record_post_action 13:10:53 INFO - ##### 13:10:53 INFO - ##### Running download-and-extract step. 13:10:53 INFO - ##### 13:10:53 INFO - Running pre-action listener: _resource_record_pre_action 13:10:53 INFO - Running main action method: download_and_extract 13:10:53 INFO - mkdir: /builds/slave/test/build/tests 13:10: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')]} 13:10:53 INFO - https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:10:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/test_packages.json 13:10:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/test_packages.json 13:10:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:10:57 INFO - Downloaded 1302 bytes. 13:10:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:10:57 INFO - Using the following test package requirements: 13:10:57 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:10:57 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:10:57 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:57 INFO - u'jsshell-linux-x86_64.zip'], 13:10:57 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:10:57 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:10:57 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:10:57 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:10:57 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:10:57 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:10:57 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:10:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:57 INFO - https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:10:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:10:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:10:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:10:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:10:59 INFO - Downloaded 22760989 bytes. 13:10:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:10:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:10:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:11:00 INFO - Return code: 0 13:11:00 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:11: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')]} 13:11:00 INFO - https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:11:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:11:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:11:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:11:03 INFO - Downloaded 22760989 bytes. 13:11:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:11:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:11:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:11:04 INFO - Return code: 0 13:11: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')]} 13:11:04 INFO - https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:11:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:11:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:11:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:11:05 INFO - Downloaded 11132285 bytes. 13:11:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 13:11:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:11:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:11:05 INFO - Return code: 0 13:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:05 INFO - https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:11:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:11:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:11:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:11:09 INFO - Downloaded 54050520 bytes. 13:11:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:11:09 INFO - mkdir: /builds/slave/test/properties 13:11:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:11:09 INFO - Writing to file /builds/slave/test/properties/build_url 13:11:09 INFO - Contents: 13:11:09 INFO - build_url:https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:11:09 INFO - Running post-action listener: _resource_record_post_action 13:11:09 INFO - Running post-action listener: set_extra_try_arguments 13:11:09 INFO - ##### 13:11:09 INFO - ##### Running populate-webroot step. 13:11:09 INFO - ##### 13:11:09 INFO - Running pre-action listener: _resource_record_pre_action 13:11:09 INFO - Running main action method: populate_webroot 13:11:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:11:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:11:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:11:09 INFO - '--tppagecycles', 13:11:09 INFO - '7'], 13:11:09 INFO - 'tests': ['tsvgm']}}, 13:11:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:11:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:11:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:11:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:11:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:11:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:11:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:09 INFO - 'talos_options': ['--e10s'], 13:11:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:09 INFO - 'tests': ['damp', 'tps']}, 13:11:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:09 INFO - 'talos_options': ['--e10s'], 13:11:09 INFO - 'tests': ['damp', 'tps']}, 13:11:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:11:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:11:09 INFO - 'other': {'tests': ['a11yr', 13:11:09 INFO - 'ts_paint', 13:11:09 INFO - 'tpaint', 13:11:09 INFO - 'sessionrestore', 13:11:09 INFO - 'sessionrestore_no_auto_restore']}, 13:11:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:11:09 INFO - 'tests': ['a11yr', 13:11:09 INFO - 'ts_paint', 13:11:09 INFO - 'tpaint', 13:11:09 INFO - 'sessionrestore', 13:11:09 INFO - 'sessionrestore_no_auto_restore']}, 13:11:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:11:09 INFO - 'tests': ['a11yr', 13:11:09 INFO - 'ts_paint', 13:11:09 INFO - 'tpaint', 13:11:09 INFO - 'sessionrestore', 13:11:09 INFO - 'sessionrestore_no_auto_restore']}, 13:11:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:11:09 INFO - 'tests': ['a11yr', 13:11:09 INFO - 'ts_paint', 13:11:09 INFO - 'tpaint', 13:11:09 INFO - 'sessionrestore', 13:11:09 INFO - 'sessionrestore_no_auto_restore']}, 13:11:09 INFO - 'other_l64': {'tests': ['a11yr', 13:11:09 INFO - 'ts_paint', 13:11:09 INFO - 'tpaint', 13:11:09 INFO - 'sessionrestore', 13:11:09 INFO - 'sessionrestore_no_auto_restore']}, 13:11:09 INFO - 'other_nol64': {'tests': ['a11yr', 13:11:09 INFO - 'ts_paint', 13:11:09 INFO - 'tpaint', 13:11:09 INFO - 'sessionrestore', 13:11:09 INFO - 'sessionrestore_no_auto_restore']}, 13:11:09 INFO - 'svgr': {'tests': ['tsvgx', 13:11:09 INFO - 'tsvgr_opacity', 13:11:09 INFO - 'tart', 13:11:09 INFO - 'tscrollx', 13:11:09 INFO - 'cart']}, 13:11:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:11:09 INFO - 'tests': ['tsvgx', 13:11:09 INFO - 'tsvgr_opacity', 13:11:09 INFO - 'tart', 13:11:09 INFO - 'tscrollx', 13:11:09 INFO - 'cart']}, 13:11:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:09 INFO - 'tests': ['tp5o']}, 13:11:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:09 INFO - 'talos_options': ['--e10s'], 13:11:09 INFO - 'tests': ['tp5o']}, 13:11:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:09 INFO - 'talos_options': ['--xperf_path', 13:11:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:09 INFO - 'tests': ['tp5n']}, 13:11:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:09 INFO - 'talos_options': ['--e10s', 13:11:09 INFO - '--xperf_path', 13:11:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:09 INFO - 'tests': ['tp5n']}}, 13:11:09 INFO - 'talos.zip': {'path': '', 13:11:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:11:09 INFO - Running post-action listener: _resource_record_post_action 13:11:09 INFO - ##### 13:11:09 INFO - ##### Running create-virtualenv step. 13:11:09 INFO - ##### 13:11:09 INFO - Running pre-action listener: _resource_record_pre_action 13:11:09 INFO - Running main action method: create_virtualenv 13:11:09 INFO - Creating virtualenv /builds/slave/test/build/venv 13:11:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:11:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:11:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:11:09 INFO - Using real prefix '/usr' 13:11:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:11:10 INFO - Installing distribute.............................................................................................................................................................................................done. 13:11:12 INFO - Installing pip.................done. 13:11:12 INFO - Return code: 0 13:11:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:12 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 0x7f5d954b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:11:12 INFO - Using env: {'DISPLAY': ':0', 13:11:12 INFO - 'HOME': '/home/cltbld', 13:11:12 INFO - 'LANG': 'en_US.UTF-8', 13:11:12 INFO - 'LANGUAGE': 'en_US:en', 13:11:12 INFO - 'LOGNAME': 'cltbld', 13:11:12 INFO - 'MAIL': '/var/mail/cltbld', 13:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:12 INFO - 'MOZ_NO_REMOTE': '1', 13:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:12 INFO - 'NO_EM_RESTART': '1', 13:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:12 INFO - 'PWD': '/builds/slave/test', 13:11:12 INFO - 'SHELL': '/bin/bash', 13:11:12 INFO - 'SHLVL': '1', 13:11:12 INFO - 'TERM': 'linux', 13:11:12 INFO - 'TMOUT': '86400', 13:11:12 INFO - 'USER': 'cltbld', 13:11:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:12 INFO - '_': '/tools/buildbot/bin/python'} 13:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:11:13 INFO - Cleaning up... 13:11:13 INFO - Return code: 0 13:11:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:13 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 0x7f5d954b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:11:13 INFO - Using env: {'DISPLAY': ':0', 13:11:13 INFO - 'HOME': '/home/cltbld', 13:11:13 INFO - 'LANG': 'en_US.UTF-8', 13:11:13 INFO - 'LANGUAGE': 'en_US:en', 13:11:13 INFO - 'LOGNAME': 'cltbld', 13:11:13 INFO - 'MAIL': '/var/mail/cltbld', 13:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:13 INFO - 'MOZ_NO_REMOTE': '1', 13:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:13 INFO - 'NO_EM_RESTART': '1', 13:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:13 INFO - 'PWD': '/builds/slave/test', 13:11:13 INFO - 'SHELL': '/bin/bash', 13:11:13 INFO - 'SHLVL': '1', 13:11:13 INFO - 'TERM': 'linux', 13:11:13 INFO - 'TMOUT': '86400', 13:11:13 INFO - 'USER': 'cltbld', 13:11:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:13 INFO - '_': '/tools/buildbot/bin/python'} 13:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:14 INFO - Downloading/unpacking psutil>=0.7.1 13:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:11:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:11:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:16 INFO - Installing collected packages: psutil 13:11:16 INFO - Running setup.py install for psutil 13:11:16 INFO - building 'psutil._psutil_linux' extension 13:11:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:11:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:11:17 INFO - building 'psutil._psutil_posix' extension 13:11:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:11:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:11:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:17 INFO - Successfully installed psutil 13:11:17 INFO - Cleaning up... 13:11:17 INFO - Return code: 0 13:11:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:11: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')]} 13:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11: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')]} 13:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11: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', '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 0x7f5d954b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:11: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 mozsystemmonitor==0.0.0 13:11:17 INFO - Using env: {'DISPLAY': ':0', 13:11:17 INFO - 'HOME': '/home/cltbld', 13:11:17 INFO - 'LANG': 'en_US.UTF-8', 13:11:17 INFO - 'LANGUAGE': 'en_US:en', 13:11:17 INFO - 'LOGNAME': 'cltbld', 13:11:17 INFO - 'MAIL': '/var/mail/cltbld', 13:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:17 INFO - 'MOZ_NO_REMOTE': '1', 13:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:17 INFO - 'NO_EM_RESTART': '1', 13:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:17 INFO - 'PWD': '/builds/slave/test', 13:11:17 INFO - 'SHELL': '/bin/bash', 13:11:17 INFO - 'SHLVL': '1', 13:11:17 INFO - 'TERM': 'linux', 13:11:17 INFO - 'TMOUT': '86400', 13:11:17 INFO - 'USER': 'cltbld', 13:11:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:17 INFO - '_': '/tools/buildbot/bin/python'} 13:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:11: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 13:11: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 13:11: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 13:11: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 13:11: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 13:11: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 13:11:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:11:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:11:19 INFO - Installing collected packages: mozsystemmonitor 13:11:19 INFO - Running setup.py install for mozsystemmonitor 13:11:19 INFO - Successfully installed mozsystemmonitor 13:11:19 INFO - Cleaning up... 13:11:19 INFO - Return code: 0 13:11:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:19 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 0x7f5d954b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:11:19 INFO - Using env: {'DISPLAY': ':0', 13:11:19 INFO - 'HOME': '/home/cltbld', 13:11:19 INFO - 'LANG': 'en_US.UTF-8', 13:11:19 INFO - 'LANGUAGE': 'en_US:en', 13:11:19 INFO - 'LOGNAME': 'cltbld', 13:11:19 INFO - 'MAIL': '/var/mail/cltbld', 13:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:19 INFO - 'MOZ_NO_REMOTE': '1', 13:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:19 INFO - 'NO_EM_RESTART': '1', 13:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:19 INFO - 'PWD': '/builds/slave/test', 13:11:19 INFO - 'SHELL': '/bin/bash', 13:11:19 INFO - 'SHLVL': '1', 13:11:19 INFO - 'TERM': 'linux', 13:11:19 INFO - 'TMOUT': '86400', 13:11:19 INFO - 'USER': 'cltbld', 13:11:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:19 INFO - '_': '/tools/buildbot/bin/python'} 13:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:19 INFO - Downloading/unpacking blobuploader==1.2.4 13:11: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 13:11: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 13:11: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 13:11: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 13:11: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 13:11: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 13:11:21 INFO - Downloading blobuploader-1.2.4.tar.gz 13:11:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:11:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:11:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:22 INFO - Downloading docopt-0.6.1.tar.gz 13:11:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:11:22 INFO - Installing collected packages: blobuploader, requests, docopt 13:11:22 INFO - Running setup.py install for blobuploader 13:11:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:11:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:11:22 INFO - Running setup.py install for requests 13:11:22 INFO - Running setup.py install for docopt 13:11:22 INFO - Successfully installed blobuploader requests docopt 13:11:22 INFO - Cleaning up... 13:11:22 INFO - Return code: 0 13:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:22 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 0x7f5d954b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:11:22 INFO - Using env: {'DISPLAY': ':0', 13:11:22 INFO - 'HOME': '/home/cltbld', 13:11:22 INFO - 'LANG': 'en_US.UTF-8', 13:11:22 INFO - 'LANGUAGE': 'en_US:en', 13:11:22 INFO - 'LOGNAME': 'cltbld', 13:11:22 INFO - 'MAIL': '/var/mail/cltbld', 13:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:22 INFO - 'MOZ_NO_REMOTE': '1', 13:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:22 INFO - 'NO_EM_RESTART': '1', 13:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:22 INFO - 'PWD': '/builds/slave/test', 13:11:22 INFO - 'SHELL': '/bin/bash', 13:11:22 INFO - 'SHLVL': '1', 13:11:22 INFO - 'TERM': 'linux', 13:11:22 INFO - 'TMOUT': '86400', 13:11:22 INFO - 'USER': 'cltbld', 13:11:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:22 INFO - '_': '/tools/buildbot/bin/python'} 13:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:22 INFO - Running setup.py (path:/tmp/pip-AnXdIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:23 INFO - Running setup.py (path:/tmp/pip-jCdcgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:23 INFO - Running setup.py (path:/tmp/pip-W7NcW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:23 INFO - Running setup.py (path:/tmp/pip-jIihHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:23 INFO - Running setup.py (path:/tmp/pip-_pE9n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:23 INFO - Running setup.py (path:/tmp/pip-TKAwAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:23 INFO - Running setup.py (path:/tmp/pip-eIfNek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:23 INFO - Running setup.py (path:/tmp/pip-XX2EfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:23 INFO - Running setup.py (path:/tmp/pip-i4Oui7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:23 INFO - Running setup.py (path:/tmp/pip-OpXQtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:23 INFO - Running setup.py (path:/tmp/pip-khuUzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:23 INFO - Running setup.py (path:/tmp/pip-KqOxwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:23 INFO - Running setup.py (path:/tmp/pip-4HaVSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:23 INFO - Running setup.py (path:/tmp/pip-6Kd7IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:23 INFO - Running setup.py (path:/tmp/pip-8eG32H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:24 INFO - Running setup.py (path:/tmp/pip-0iyiMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:24 INFO - Running setup.py (path:/tmp/pip-U2cOYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:11:24 INFO - Running setup.py install for manifestparser 13:11:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:11:24 INFO - Running setup.py install for mozcrash 13:11:24 INFO - Running setup.py install for mozdebug 13:11:24 INFO - Running setup.py install for mozdevice 13:11:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:11:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:11:24 INFO - Running setup.py install for mozfile 13:11:24 INFO - Running setup.py install for mozhttpd 13:11:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:11:24 INFO - Running setup.py install for mozinfo 13:11:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:11:24 INFO - Running setup.py install for mozInstall 13:11:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Running setup.py install for mozleak 13:11:25 INFO - Running setup.py install for mozlog 13:11:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Running setup.py install for moznetwork 13:11:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Running setup.py install for mozprocess 13:11:25 INFO - Running setup.py install for mozprofile 13:11:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Running setup.py install for mozrunner 13:11:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Running setup.py install for mozscreenshot 13:11:25 INFO - Running setup.py install for moztest 13:11:25 INFO - Running setup.py install for mozversion 13:11:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:11:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:11:25 INFO - Cleaning up... 13:11:25 INFO - Return code: 0 13:11:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f5d954b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:11:25 INFO - Using env: {'DISPLAY': ':0', 13:11:25 INFO - 'HOME': '/home/cltbld', 13:11:25 INFO - 'LANG': 'en_US.UTF-8', 13:11:25 INFO - 'LANGUAGE': 'en_US:en', 13:11:25 INFO - 'LOGNAME': 'cltbld', 13:11:25 INFO - 'MAIL': '/var/mail/cltbld', 13:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:25 INFO - 'MOZ_NO_REMOTE': '1', 13:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:25 INFO - 'NO_EM_RESTART': '1', 13:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:25 INFO - 'PWD': '/builds/slave/test', 13:11:25 INFO - 'SHELL': '/bin/bash', 13:11:25 INFO - 'SHLVL': '1', 13:11:25 INFO - 'TERM': 'linux', 13:11:25 INFO - 'TMOUT': '86400', 13:11:25 INFO - 'USER': 'cltbld', 13:11:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:25 INFO - '_': '/tools/buildbot/bin/python'} 13:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:26 INFO - Running setup.py (path:/tmp/pip-lvsHDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:26 INFO - Running setup.py (path:/tmp/pip-oUNMBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:26 INFO - Running setup.py (path:/tmp/pip-F6jo2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:26 INFO - Running setup.py (path:/tmp/pip-TiRNoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:26 INFO - Running setup.py (path:/tmp/pip-3tvyhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:26 INFO - Running setup.py (path:/tmp/pip-7B75At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:26 INFO - Running setup.py (path:/tmp/pip-Yyidc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:26 INFO - Running setup.py (path:/tmp/pip-U75yXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:26 INFO - Running setup.py (path:/tmp/pip-ukB2Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:26 INFO - Running setup.py (path:/tmp/pip-Ad2u0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:26 INFO - Running setup.py (path:/tmp/pip-GRcnZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:27 INFO - Running setup.py (path:/tmp/pip-ZUOukJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:27 INFO - Running setup.py (path:/tmp/pip-MNlPKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:27 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)) 13:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:27 INFO - Running setup.py (path:/tmp/pip-vt0i3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:27 INFO - Running setup.py (path:/tmp/pip-_Zoorw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:27 INFO - Running setup.py (path:/tmp/pip-NuKzQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:27 INFO - Running setup.py (path:/tmp/pip-l_8Fpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:11:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:29 INFO - Downloading blessings-1.5.1.tar.gz 13:11:29 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:11:29 INFO - Installing collected packages: blessings 13:11:29 INFO - Running setup.py install for blessings 13:11:29 INFO - Successfully installed blessings 13:11:29 INFO - Cleaning up... 13:11:29 INFO - Return code: 0 13:11:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:29 INFO - Reading from file tmpfile_stdout 13:11:29 INFO - Current package versions: 13:11:29 INFO - argparse == 1.2.1 13:11:29 INFO - blessings == 1.5.1 13:11:29 INFO - blobuploader == 1.2.4 13:11:29 INFO - docopt == 0.6.1 13:11:29 INFO - manifestparser == 1.1 13:11:29 INFO - mozInstall == 1.12 13:11:29 INFO - mozcrash == 0.16 13:11:29 INFO - mozdebug == 0.1 13:11:29 INFO - mozdevice == 0.47 13:11:29 INFO - mozfile == 1.2 13:11:29 INFO - mozhttpd == 0.7 13:11:29 INFO - mozinfo == 0.9 13:11:29 INFO - mozleak == 0.1 13:11:29 INFO - mozlog == 3.1 13:11:29 INFO - moznetwork == 0.27 13:11:29 INFO - mozprocess == 0.22 13:11:29 INFO - mozprofile == 0.28 13:11:29 INFO - mozrunner == 6.11 13:11:29 INFO - mozscreenshot == 0.1 13:11:29 INFO - mozsystemmonitor == 0.0 13:11:29 INFO - moztest == 0.7 13:11:29 INFO - mozversion == 1.4 13:11:29 INFO - psutil == 3.1.1 13:11:29 INFO - requests == 1.2.3 13:11:29 INFO - wsgiref == 0.1.2 13:11:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:29 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 0x7f5d954b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:11:29 INFO - Using env: {'DISPLAY': ':0', 13:11:29 INFO - 'HOME': '/home/cltbld', 13:11:29 INFO - 'LANG': 'en_US.UTF-8', 13:11:29 INFO - 'LANGUAGE': 'en_US:en', 13:11:29 INFO - 'LOGNAME': 'cltbld', 13:11:29 INFO - 'MAIL': '/var/mail/cltbld', 13:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:29 INFO - 'MOZ_NO_REMOTE': '1', 13:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:29 INFO - 'NO_EM_RESTART': '1', 13:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:29 INFO - 'PWD': '/builds/slave/test', 13:11:29 INFO - 'SHELL': '/bin/bash', 13:11:29 INFO - 'SHLVL': '1', 13:11:29 INFO - 'TERM': 'linux', 13:11:29 INFO - 'TMOUT': '86400', 13:11:29 INFO - 'USER': 'cltbld', 13:11:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:29 INFO - '_': '/tools/buildbot/bin/python'} 13:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:29 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)) 13:11:29 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)) 13:11:29 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)) 13:11:29 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)) 13:11:29 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)) 13:11:29 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)) 13:11:29 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)) 13:11:29 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)) 13:11:29 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)) 13:11:29 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)) 13:11:29 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)) 13:11:29 INFO - Cleaning up... 13:11:29 INFO - Return code: 0 13:11:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:29 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 0x7f5d954b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:11:29 INFO - Using env: {'DISPLAY': ':0', 13:11:29 INFO - 'HOME': '/home/cltbld', 13:11:29 INFO - 'LANG': 'en_US.UTF-8', 13:11:29 INFO - 'LANGUAGE': 'en_US:en', 13:11:29 INFO - 'LOGNAME': 'cltbld', 13:11:29 INFO - 'MAIL': '/var/mail/cltbld', 13:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:29 INFO - 'MOZ_NO_REMOTE': '1', 13:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:29 INFO - 'NO_EM_RESTART': '1', 13:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:29 INFO - 'PWD': '/builds/slave/test', 13:11:29 INFO - 'SHELL': '/bin/bash', 13:11:29 INFO - 'SHLVL': '1', 13:11:29 INFO - 'TERM': 'linux', 13:11:29 INFO - 'TMOUT': '86400', 13:11:29 INFO - 'USER': 'cltbld', 13:11:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:29 INFO - '_': '/tools/buildbot/bin/python'} 13:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:30 INFO - Downloading/unpacking jsonschema 13:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:11:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:11:31 INFO - Downloading/unpacking functools32 (from jsonschema) 13:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:11:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:11:32 INFO - warning: no files found matching '*.txt' 13:11:32 INFO - no previously-included directories found matching 'build' 13:11:32 INFO - no previously-included directories found matching 'dist' 13:11:32 INFO - no previously-included directories found matching '.git*' 13:11:32 INFO - Installing collected packages: jsonschema, functools32 13:11:32 INFO - Running setup.py install for functools32 13:11:32 INFO - warning: no files found matching '*.txt' 13:11:32 INFO - no previously-included directories found matching 'build' 13:11:32 INFO - no previously-included directories found matching 'dist' 13:11:32 INFO - no previously-included directories found matching '.git*' 13:11:32 INFO - Successfully installed jsonschema functools32 13:11:32 INFO - Cleaning up... 13:11:32 INFO - Return code: 0 13:11:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:32 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 0x7f5d954b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:11:32 INFO - Using env: {'DISPLAY': ':0', 13:11:32 INFO - 'HOME': '/home/cltbld', 13:11:32 INFO - 'LANG': 'en_US.UTF-8', 13:11:32 INFO - 'LANGUAGE': 'en_US:en', 13:11:32 INFO - 'LOGNAME': 'cltbld', 13:11:32 INFO - 'MAIL': '/var/mail/cltbld', 13:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:32 INFO - 'MOZ_NO_REMOTE': '1', 13:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:32 INFO - 'NO_EM_RESTART': '1', 13:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:32 INFO - 'PWD': '/builds/slave/test', 13:11:32 INFO - 'SHELL': '/bin/bash', 13:11:32 INFO - 'SHLVL': '1', 13:11:32 INFO - 'TERM': 'linux', 13:11:32 INFO - 'TMOUT': '86400', 13:11:32 INFO - 'USER': 'cltbld', 13:11:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:32 INFO - '_': '/tools/buildbot/bin/python'} 13:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:32 INFO - Downloading/unpacking flake8 13:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:11:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:11:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:11:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:11:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:11:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:11:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:11:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:11:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:11:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:11:34 INFO - no previously-included directories found matching 'docs/_build' 13:11:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:11:34 INFO - Running setup.py install for pep8 13:11:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:11:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:11:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:11:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:11:35 INFO - no previously-included directories found matching 'docs/_build' 13:11:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:11:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:11:35 INFO - Cleaning up... 13:11:35 INFO - Return code: 0 13:11:35 INFO - Running post-action listener: _resource_record_post_action 13:11:35 INFO - Running post-action listener: _start_resource_monitoring 13:11:35 INFO - Starting resource monitoring. 13:11:35 INFO - ##### 13:11:35 INFO - ##### Running install step. 13:11:35 INFO - ##### 13:11:35 INFO - Running pre-action listener: _resource_record_pre_action 13:11:35 INFO - Running main action method: install 13:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:35 INFO - Reading from file tmpfile_stdout 13:11:35 INFO - Detecting whether we're running mozinstall >=1.0... 13:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:11:35 INFO - Reading from file tmpfile_stdout 13:11:35 INFO - Output received: 13:11:35 INFO - Usage: mozinstall [options] installer 13:11:35 INFO - Options: 13:11:35 INFO - -h, --help show this help message and exit 13:11:35 INFO - -d DEST, --destination=DEST 13:11:35 INFO - Directory to install application into. [default: 13:11:35 INFO - "/builds/slave/test"] 13:11:35 INFO - --app=APP Application being installed. [default: firefox] 13:11:35 INFO - mkdir: /builds/slave/test/build/application 13:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:11:51 INFO - Reading from file tmpfile_stdout 13:11:51 INFO - Output received: 13:11:51 INFO - /builds/slave/test/build/application/firefox/firefox 13:11:51 INFO - Running post-action listener: _resource_record_post_action 13:11:51 INFO - ##### 13:11:51 INFO - ##### Running run-tests step. 13:11:51 INFO - ##### 13:11:51 INFO - Running pre-action listener: _resource_record_pre_action 13:11:51 INFO - Running main action method: run_tests 13:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:11:51 INFO - Python 2.7.3 13:11:51 INFO - Return code: 0 13:11:51 INFO - grabbing minidump binary from tooltool 13:11: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')]} 13:11:51 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 0x1e773d0>, '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 0x1de2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de3360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:11:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:11:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:11:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:11:51 INFO - Return code: 0 13:11:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:11:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:11:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:11:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:11:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:11:52 INFO - Return code: 0 13:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 13:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 13:11:52 INFO - Using env: {'DISPLAY': ':0', 13:11:52 INFO - 'HOME': '/home/cltbld', 13:11:52 INFO - 'LANG': 'en_US.UTF-8', 13:11:52 INFO - 'LANGUAGE': 'en_US:en', 13:11:52 INFO - 'LOGNAME': 'cltbld', 13:11:52 INFO - 'MAIL': '/var/mail/cltbld', 13:11:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:11:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:52 INFO - 'MOZ_NO_REMOTE': '1', 13:11:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:52 INFO - 'NO_EM_RESTART': '1', 13:11:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:52 INFO - 'PWD': '/builds/slave/test', 13:11:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:11:52 INFO - 'SHELL': '/bin/bash', 13:11:52 INFO - 'SHLVL': '1', 13:11:52 INFO - 'TERM': 'linux', 13:11:52 INFO - 'TMOUT': '86400', 13:11:52 INFO - 'USER': 'cltbld', 13:11:52 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776', 13:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:52 INFO - '_': '/tools/buildbot/bin/python'} 13:11:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 13:11:52 INFO - mozversion application_buildid: 20160109115632 13:11:52 INFO - mozversion application_changeset: c33f30666b37dbceffb9fbe5089a668db8893a85 13:11:52 INFO - mozversion application_display_name: Nightly 13:11:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:11:52 INFO - mozversion application_name: Firefox 13:11:52 INFO - mozversion application_remotingname: firefox 13:11:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:11:52 INFO - mozversion application_vendor: Mozilla 13:11:52 INFO - mozversion application_version: 46.0a1 13:11:52 INFO - mozversion platform_buildid: 20160109115632 13:11:52 INFO - mozversion platform_changeset: c33f30666b37dbceffb9fbe5089a668db8893a85 13:11:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:11:52 INFO - mozversion platform_version: 46.0a1 13:11:52 INFO - using testdate: 1452373912 13:11:52 INFO - actual date: 1452373912 13:11:52 INFO - starting webserver on 'localhost:51603' 13:11:52 INFO - SUITE-START | Running 3 tests 13:11:52 INFO - TEST-START | dromaeo_css 13:11:52 INFO - operating with platform_type : linux_ 13:11:52 INFO - Initialising browser for dromaeo_css test... 13:11:52 INFO - TEST-INFO | started process 3452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcnJ3jT/profile http://localhost:51603/getInfo.html) 13:12:00 INFO - PROCESS | 3452 | __metrics Screen width/height:1600/1200 13:12:00 INFO - PROCESS | 3452 | colorDepth:24 13:12:00 INFO - PROCESS | 3452 | Browser inner width/height: 1024/697 13:12:00 INFO - PROCESS | 3452 | __metrics 13:12:00 INFO - PROCESS | 3452 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:12:00 INFO - PROCESS | 3452 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:12:02 INFO - TEST-INFO | 3452: exit 0 13:12:02 INFO - Browser initialized. 13:12:02 INFO - Running cycle 1/1 for dromaeo_css test... 13:12:02 INFO - TEST-INFO | started process 3547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcnJ3jT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:14 INFO - PROCESS | 3547 | RSS: Main: 148922368 13:12:14 INFO - PROCESS | 3547 | 13:13:05 INFO - PROCESS | 3547 | 1452373985393 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:15:16 INFO - PROCESS | 3547 | Cycle 1(1): loaded http://localhost:51603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51603/tests/dromaeo/cssquery-ext.html) 13:15:17 INFO - PROCESS | 3547 | RSS: Main: 265572352 13:15:17 INFO - PROCESS | 3547 | 13:18:20 INFO - PROCESS | 3547 | Cycle 1(1): loaded http://localhost:51603/tests/dromaeo/cssquery-ext.html (next: http://localhost:51603/tests/dromaeo/cssquery-jquery.html) 13:18:20 INFO - PROCESS | 3547 | RSS: Main: 230105088 13:18:20 INFO - PROCESS | 3547 | 13:21:23 INFO - PROCESS | 3547 | Cycle 1(1): loaded http://localhost:51603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51603/tests/dromaeo/cssquery-mootools.html) 13:21:23 INFO - PROCESS | 3547 | RSS: Main: 243118080 13:21:23 INFO - PROCESS | 3547 | 13:24:25 INFO - PROCESS | 3547 | Cycle 1(1): loaded http://localhost:51603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51603/tests/dromaeo/cssquery-prototype.html) 13:24:26 INFO - PROCESS | 3547 | RSS: Main: 218329088 13:24:26 INFO - PROCESS | 3547 | 13:27:29 INFO - PROCESS | 3547 | Cycle 1(1): loaded http://localhost:51603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51603/tests/dromaeo/cssquery-yui.html) 13:27:29 INFO - PROCESS | 3547 | RSS: Main: 217911296 13:27:29 INFO - PROCESS | 3547 | 13:30:32 INFO - PROCESS | 3547 | Cycle 1(1): loaded http://localhost:51603/tests/dromaeo/cssquery-yui.html (next: http://localhost:51603/tests/dromaeo/cssquery-dojo.html) 13:30:32 INFO - PROCESS | 3547 | RSS: Main: 261844992 13:30:32 INFO - PROCESS | 3547 | 13:30:32 INFO - PROCESS | 3547 | __start_tp_report 13:30:32 INFO - PROCESS | 3547 | _x_x_mozilla_page_load 13:30:32 INFO - PROCESS | 3547 | _x_x_mozilla_page_load_details 13:30:32 INFO - PROCESS | 3547 | |i|pagename|runs| 13:30:32 INFO - PROCESS | 3547 | |0;dojo.html;2533.404649907272;2631.513170063537;2635.2489540480965;2647.444036752282;2656.242970753335;4324.200022995748;4459.843905463309;4496.437945256839;4506.143832671794;4507.05351876106;4424.823007079713;4461.219286624844;4463.062756821071;4492.618127459162;4495.662825288108;4217.704760666755;4237.08902585944;4290.077633308838;4293.2701440755145;4310;89.45315871658262;4104.917901641966;4193.412922190896;4199.223143718422;4321.503027151886;4150.775521221247;4158.251514727348;4172.040430700956;4173.019340454991;4177.289860723684;4095.1400205956784;4149.83400663973;4167.708260421772;4175.206710724952;4203.159368126387;4208.200441916026;4212.473440819897;4212.87361379156;4220.936685949713;4256.574342565718;4476.977615111936;4497.707649002804;4511;4523.796429160663;4570.977145114286;4674.018456124218;4759.452662943737;4774.212254977924;4797.496262892381;4914;4886.821025784077;4888.657793954425;4892.926606100911;4895.290182923492;4896.877578060541;4539.387182730289;4544.568266014757;4545.977270113662;4578.9771051144535;4580.839670611546;4768.61851051915;4835.661503694778;4900.387451568554;4901.877453063702;4973.104841128632;4700.08348372071;4745.477997420281;4745.5966242869745;4755.191617425046;4784.928226076611;4809.687370320918;4813.927791083137;4818.518148185153;4824.276358546246;4861.1006963711825;4508.526604706459;4666.929996050062;4681.836135735233;4766.308885211694;4874.098291816025;4779.976100119547;4792.400949881265;4796.35249241348;4801.615870730333;4821.059893320768;4063.7358571692744;4065.6950728695465;4076.612721791425;4087.325591277406;4101.466809314829;3479.860805567749;3554.751167418256;3592.515010473605;3593.6945359644724;3606.404943184345;4199.769012704331;4206.284931561642;4229;4235.703500754979;4270.402143699885;4884.389451318585;4884.609231261491;4887.560119589183;4900.607951363882;4934.975325123423;4107.753534787922;4121.9587804122175;4198.349255865346;4201.495820501498;4222.3244280914905;4356.716813407118;4360.738355698668;4361.454818147731;4362.258416069276;4367.868963931087;4616.215243408561;4632.328312394751;4638.605718513897;4647.744374059459;4679.368285281444;4642.907141857077;4763.428388593391;4774.880627984328;4804.399450068741;4871.8294859681155;4610.769461526843;4622.1911165545225;4631.583157515705;4642.675012749075;4668.533146685304;4807.471178170328;4810.687305325143;4813.085513752376;4834.057358814997;4874.195757699939;4682.672212945061;4799.352087468147;4799.472058073539;4809.038192361471;4856.441509226484;4712.835050773207;4723.267893476516;4728.385309909827;4741.857744267678;4757.619390448686;4702.694324868872;4715.316279139437;4715.41057367829;4732.219183834629;4755.334253204624;4470.642348612038;4512.368268442487;4575.725456472623;4582.839600614096;4626.0979109073405;4699;4737.502562231054;4839.516048395132;4893.877653058702;4902.436219834622;4661.277501987197;4680.531946805292;4682.695624784378;4685.226937555265;4733.431988161443 13:30:32 INFO - PROCESS | 3547 | |1;ext.html;489.2758717098696;495.8066354121891;509.9107656160172;519.9480051994799;520.3131865936963;24541.141060062902;25051.874740626296;25090;25107.62338564923;25133.497330053433;25173.118940837074;25569.74430255697;25595;32503.67496325036;33334;7538.47230693853;7692.115406728214;7701.422393320496;7702.191269916662;7704.422168337369;7442.851142977137;7588.734394296201;7589.392848572129;7592.734254301101;7597.050368703912;6794.830129246759;6996.510244282902;6998.615076170809;7543.7736867894055;9652.613895444174;9414.293927955396;9474.242060635133;9539.90460095404;9549.61801527938;9554.713358599183;9385.249180065579;9528.761780955532;9531.809363812754;9532.809343813155;9536.666216682383;29439.85280073586;30033.69966300353;30125.397492050255;30152.396952060837;32722.509162362585;2149.161826887515;2183.366823621148;2791.5812628105746;2803.3272014716526;3392.915177120567;23916.162934297216;24257.878710606336;24282;24419.38951526226;24632.13787517428;3310.4372256716415;3310.940499040308;3328.084776686431;3331.3503866745996;3388.6611338866164;140051;140203;140307;140687;178064;44731.552684472736;48068;48409.757951210726;48461.27308090311;48475.515244847804;39520.80239598841;39643.60356396457;39666;39678.20643587112;55269;12934.159279646981;13056.673583160307;13089.541866034642;13123.015773817002;13161.60515184546;10040.246981476419;10181.898181018096;10192.082712555757;10193;10194.541245643964;16855;16860.91569542169;16941;16983.405580804614;17022;6780.1524809398825;7099.467539934525;7131.322524360177;7142.607156606333;7196.820079498055;785.8349746553173;847.3348421489102;848.6520526584194;863.4560227056913;908.5775114571624;25262.242132736046;25569.8721506395;25611.61582576263;25714.485710286062;25808.48383032329;869.0527325215545;894.141624040928;900.1898291537537;921.3366376209119;933.780561568031;13223;13293.73412531744;13419;13484.797728034087;13532.32338383077;256466;260420;261252;261317;261716;44209.778951105036;44227.11545769066;44428.55571444244;44457.555424445345;44468;1121.4168632311316;1156.8033434316187;1174.6945794093426;1186.6618013866007;1206.927584344942;23809.761902381448;25055.373615659755;26255.60616590791;28777.712222877504;28790.712092878803;35700.107497311736;39843.800780997066;39913.80043099766;40410.39384409178;40444.393334099426;145893;148029;330049;344650;345218;27494.862525687244;27573.31066723348;27592.310192245353;27611.44777104487;27696.584551231346;37813.243735125696;38247.80876095602;38438.80780596191;38743.612563875125;38972.6102738969;31996.360072798878;32957.67042329546;32987.835060824546;33582;33818;30698;32029.199270017503;32502.187445314055;32944.34111317808;33556.496652549744;29002;29068.27329316784;29301.41397172087;29332;29377.706222937497;26227.344316392242;28151.71848281491;28501.287467812643;28528.42943141084;28535;22142.22502212415;22361.217357392412;22602.773972260067;22649.320520384415;22802.885985569967 13:30:32 INFO - PROCESS | 3547 | |2;jquery.html;311.6509509349529;322.4437844717862;323.5486496337609;329.8779451602907;339.87934283329434;11674.474648640811;12115.394230288495;15067.924660376697;15506.147161906105;15633.530994070168;14060.718785624282;14498.767604753608;14697.632559186026;15465;15468.303926323315;4763.214069678499;4869.561739443449;4987.8254261100865;5062.848114556551;5066.544011039005;3296.6868147525947;3464.3764122457947;4901.387326584177;5065.088284108859;5273.4199238083975;5015.924761128586;5259.053370393328;5279.2872962150195;5298;5306.548943339821;5087.643864929457;5121.2318152277085;5126.102931986925;5128.743457852813;5134.435212126682;4788.9521104788855;4909;4927.876803079916;5192.844214673566;5230.241614965808;17717.291308347652;18359.449216523524;18370.816291837044;18374;18695.71956420641;1730.1176400035947;1771.5836778357075;1807.0242069282572;1816.4732227654097;1905.3140869287045;8946.86579701305;9429.528523573863;10018.59925602975;12010.879891201064;12375.938120309342;1648.3900956645998;1715.8627309815186;1735.6615459985182;1765.4262364731385;1824.3797108982876;50037.24944125841;51626.74186629043;52019.2881288525;52151.47848521542;52920;9450.810983780424;9642.71071867845;9650.227981761442;9663.178629816544;9732.513374331254;12470.314132722606;12474.376281185905;12487.812682809765;12491.750164996649;12495.187812792321;6801.2858649841055;6928.237893831674;6986.615736134459;7005.964970175117;7079.646017699094;6619.735210591619;6620.966895165589;6677.966610166918;6695.363940425652;6703.865922681616;4068.105016896278;4145.626893579592;4153;4183.707140500136;4189.518205406417;1555.1368990210315;1606.9276882540314;1627.983720162807;1632.9755053674205;1686.7807185065863;763.4236151705538;807.4690890739437;819.4632515702106;826.1985873702499;925.9444233573731;11295.661130165943;14736.852631473763;14798.704025919422;14998.775018374734;15245.542633721006;767.6622286194057;809.9433039687283;827.9917200828035;835.7116794705817;844.4933040175845;7965.163657815961;8218.958905205436;8309.95845020771;8412.915870841336;8736.388452808242;449442;454064.6748260131;454881;459127;467526;59521.40478595245;61738.69130654318;62964.370356296764;63237;63256.68371658112;1023.2632504596678;1056.2606175676904;1079.7205311705497;1085.8968398002178;1087.8259478483405;12564.685882853002;13591.932040339734;13821.101628394123;13862;13940;29914.70085299119;30240.84879575588;30292.84853575718;31121.533177002817;31458.842705786323;40276.597234027286;40300.178987470594;40314.798426007685;40365.39451908165;40427.797861011684;6399.968000159969;6482.481401487776;6708.765193218214;6716.261211266855;6759.290274521104;2999.550067489894;3967.26605577969;5712.742926568398;9297.907020929704;10020.749481263027;8132.186781322057;8500.70247541333;8562.828743425222;8602.82794344097;8672.479651220947;8518.190771876662;8703.173198546128;8944.105589441004;9092;9147.954260228656;5970.880582388415;7994.760157195294;8182.386321026066;8297.95851020741;8726.865507483986;6496.902546461902;6563.409293163447;6566.967165164144;6617.139771829631;6781.355771201728;7712;8458.450200736932;8481.363897707573;8528.251708399886;8595.312375009858 13:30:32 INFO - PROCESS | 3547 | |3;mootools.html;1234.8086046662759;1361.4145917255582;1379.9034067615269;1493.7161939231546;1731.6536692661464;6090.5736598438125;6225.937740622592;7087.1495420549545;7288.125424949014;7323.963380183105;7244.311790379906;7264.6367681615975;7304.196538380774;7326;7337.706491740324;1742.8431441170292;1786.0355408079622;2122.246602456129;2150.6451435513122;2154.741431028279;2128.925487607934;2183.4977955070344;2186.431527802775;2187.9562408751817;2188.912443502258;2129.37183530858;2137.2733270687963;2173.8913054347217;2174.141214220382;2178.117862265785;2140.154638917634;2147.1196809308185;2158.6761985702115;2159.6112699714045;2188.0372636040092;2130.1692339987417;2144.485323522359;2151.7202763640626;2170.913163473459;2173.521825198454;7432.85134297311;7469.103707555074;7476.102867655916;7477.439192060618;7481.139668938087;4245.299525578276;4339.349097635349;4368.759718215497;4373.409589705413;4374.059577190919;2820.5910143029146;2822.3649678822308;2924.8391338476376;2926.4732348177317;2934.3691106412225;917.1149840404042;924.5608336040394;939.3800091939287;942.2273735536862;951.3388195204336;10050.145737612313;10244.231682623758;10245.231607629457;10250.794984100276;10260.589576416935;4107.178564287155;4133.751974881517;4179.101493178981;4196.958030419718;4207.852725154605;8839.734807955772;8850.513221772864;8859.689910853089;8866.202041816268;8870.600822962982;4425.291953287523;4459.487158976694;4462.419885414875;4462.509123996358;4467.486239082482;4006.4991876015497;4007.1785284016705;4007.579204183519;4014.1971605678395;4022.4971878515184;3110.9533356999664;3167.2715275486307;3177.777555571134;3390.677885600864;3489.546358973368;984.1978787288338;990.5096976996289;1139.9487023083982;1164.336328292865;1173.8004539228352;1177.4289469607234;1184.2894263441865;1188.6612315490045;1206.252123683322;1212.018265205169;6675.532712710161;6720.932790672128;6733.091032710619;6739.730410783612;6746.460283177334;978.280963491833;981.2885657897967;997.6059456514781;1014.2697257974247;1014.6043043213152;5321.361436627552;5358.5981051421295;5466.945330546723;5468.343798744176;5473.698946557898;8810;8883.822323553622;9102.453852768855;9121.543922803834;9128.361014728906;8993.730188094367;9084.591193396182;9088.136627020422;9116.954415227881;9123.36136470454;7002.299770022957;7071.398931090812;7074.115735533059;7075.150981882207;7079.548692518021;6421.229452465734;6510.511711621552;6572.76995305162;6578.539502234989;6592.70332835014;7720.073591169095;7794.415418843496;7805.375569954504;8224.136465671018;8226.547539885363;8234.382421318545;8437.746867593982;8438.704645337384;8553.700620478503;8554.91445085566;6414.871702566016;6476.935230647821;6483.708233129426;6485.254195767548;6486.37840539865;6725.725032168741;6823.38589526945;6826.112605361272;6843.178818541807;6845.520813543004;5602.803901863415;5681.488666020078;6326.4622507087415;6365;6370.617762934239;6293.433590976834;6301.306856245717;6366.745330186741;6379.393957574023;6382.680865956777;6419.133416988647;6464.967675161594;6465.191851018622;6482.384173503509;6498.545101842826;5822.475977162076;5985.491233245223;6025.307089684742;6039.365866583946;6039.818805435844;5796.507296879812;6125.663088529996;6132.448079672851;6141.7543298267565;6142.293636231891 13:30:32 INFO - PROCESS | 3547 | |4;prototype.html;312.77323940143395;317.66169029983064;319.72663372816237;321.5369867390958;324.22995385958365;5158.7936482540745;5207.583393328534;5323.9467605323935;5428.050091234038;5468.3711373192045;5106.872328191787;5262.105442074847;5274.973625131878;5278.996990571789;5302.840914772553;3902.843886244561;4019.8995025124314;4131.690123240754;4134.793260336986;4140.792960351985;4034.23349563582;4125.154343359604;4134.52452967908;4138.8137533810905;4146.129312844307;4086.1419101988618;4095.75425474471;4099.221147981889;4103.261412945669;4103.835846566134;4102.630763231294;4102.958970410303;4113.979430102845;4115.814788334532;4116.176764647083;3599.4960705501253;3600.1899572596217;3600.6399360064047;3600.9279814403567;3604.6936010439144;4973.4280557735965;5086.821961231339;5090.821821236276;5106.64253502255;5114.488551144893;4688.062387522475;4688.507706690816;4698.835540756091;4699.577038066591;4703.435587729495;5251.317328747276;5531.170324451325;5531.225628412026;5533.750981205855;5571.9721401392735;3773.52830896138;3815.1606646537716;3826.043489127718;3829.5787463379006;3873.748206366577;5757.769689212427;5804.332501762309;5820.912686309709;5837.416258374171;5844.211031510734;4008.6793056555407;4014.7791871446766;4018.07584255617;4019.2765302245875;4024.0342317843506;3985.3025720499377;4069.308217603015;4072.4095006224525;4077.6330130288416;4079.4288799568085;4658.231391820379;4669.60308373792;4671.416072990876;4671.813127474863;4678.111158879802;5483.067878460672;5534.335879694462;5538.141588053858;5553.6390134641115;5557;1431.77807439847;1451.0060608483222;1451.1293224065687;1452.3101526774697;1452.6077958951234;979.9559019844124;986.1529316611549;986.2750878104588;986.4229425785995;1009.8838633557089;4841.789552611847;4905.264210368473;4910.140725373046;4912.140375434285;4917.164082106051;5759.2512973313205;5761.683107429131;5762.4525670061275;5765.3369862465515;5770.307563092456;4902.142125128088;4910.189818679949;4913.877153071202;4916.803327866917;4919.139150648693;3024.9697503024686;3111.7355024823146;3120.469520181575;3127.390158918989;3131.1076343242066;5486.478784515464;5508.614396992172;5512.310961129859;5513.8345849624575;5514.779408823602;5986.2517185351835;5991.460768530853;5993.910091348634;5995.100734889801;5996.430339117776;5499;5504.862378440571;5505.614606977553;5506.449355064461;5512.614117011771;5689.402612725604;5832.475077243069;5836.591438599257;5839.883202336015;5840.036393994943;5420.4850539198715;5479.75341109659;5555.0834112371;5602.215689803512;5608.242887210337;5422.05114105038;5428.864278393072;5461.071617825059;5461.2627295316215;5470.699111548903;3980.024893901013;4017.2367250222364;4017.6584990276156;4018.216447792652;4021.2962731522452;5606.355269144101;5776.913346299725;5781.82654520365;5783.797567085132;5796.971015144897;5583.776648933997;5608.355039170548;5612.803551875665;5613.803516876889;5614.24207731951;5608.439156084522;5637.887242255214;5656.830295091154;5667.3765885753355;5673.602847800615;5370.919436208382;5491.478309560585;5499.285092937893;5503.2020357048805;5505.256790333254;5633.436656334334;5642.520385767256;5644.717764111861;5646.774129034792;5652.519535839499;5502.339719233718;5510.090835012178;5515.310586176728;5516.200150978006;5516.889662206813 13:30:32 INFO - PROCESS | 3547 | |5;yui.html;646.9320721324261;679.9155347221182;744.8510297940413;747.835476195237;767.3784234769837;10559.41923194224;10685.732856678587;10722.624708135218;12450.564230251943;12712.872871271284;12289.139760216765;12365;12376;12378.504859805596;12379.25724456531;609.7012463892682;617.0466629058116;760.7831767946136;767.5087943716027;780.2509590792846;774.4927072767347;777.2460713108276;780.6682160081971;782;782.077148964222;800.8798680197958;808.2321794295414;810.5987536169575;811.7240138352959;811.7240138352959;621.3599992008238;631.0093153748594;799.9800004999863;819.3854609043218;819.7417813388763;594;601.7923816283375;603.3513972479558;603.7796204385412;603.8701679139007;10650.307729997525;10652.840207396895;10664.253502254845;10707.785844283071;10748.247622666417;11185.217034807567;11437.370944598044;11467.426628668616;11544.653660390202;11585.420728963518;8705.956470217609;8723.171298726611;8760.080191579857;8776.429532080458;8784.34117441188;3154.2587491939375;3186.6176058873084;3215.485522316418;3232.305054413289;3241.205904553376;37020;37146.62853371459;37290.25419491622;37598.62401376006;37633.81183094067;8854.557272136368;9015.549222538846;9031.819363612822;9047.864282035775;9070.092990700878;15516.456924007605;15649.29578168985;15661.060336379855;15702.76445853313;15718.607034823992;6271.811845644638;6331;6333.334999825044;6396.360363963567;6415;3491.773034752733;3516.542849429609;3522.682958533744;3549.9290014200087;3620.728445366608;2596.818222724429;2638.643783089297;2639.0367515856574;2640.564306889342;2644.3917898883365;479.92321228603953;488.726313264573;490.2181021271067;492.6748346091562;495.03468236938113;501.86198795331575;549.793827314757;577.6158854361802;580.9796657116981;599.6941559804532;7440.962795185989;7445.5532668039;7463.029806125278;7579.279968402993;7582.279683430065;460.45436158152694;464.71884509871717;468.57359802579487;480.92545655423464;548.8079172289747;3280.2291461506525;3357.462805951036;3417.1457135716073;3540.0795793093466;3580.874669386559;45293.54706452959;45900;45973.310400344024;45973.77013114913;45993.08013839705;40695.796521017204;40977.59022409797;41055;41213.58786412098;41442.1711565773;37550.624493754716;37646.62353376431;38027.80986095052;38253.80873095673;38424.80787596044;7149.60677162761;7155.320244576965;7960.920390796018;8076.353891688768;8093.55485448306;27499.587506187025;30130;30151.849240753654;30174.245643859078;30216.84891575528;37990.24019519649;38032.23935521219;38339.6166038336;38411.039724007125;38457.42313865238;9931.304808663324;9963.950180249052;10016.899831001596;10185.439800811026;10216;10713.625023124154;10877.238593298709;10936.289141206114;10995.780084398428;11075.224734268524;10544.630937917136;10599.735006624587;10632.468376580986;10813.134949203888;10813.783724325627;10054.34646747959;10215.131713804112;10235.539400726837;10235.897641023792;10625.043746062891;9864.309498335047;10129.746756331151;10199.0820826126;10281.84577231357;10505.054545090978;8233.423660343718;8236.629351679308;8433.578321084044;8468.322534197372;8720.258778003687;8854.867176992479;9005.099490050943;9014.278857691237;9038.186563209343;9075.455472671661 13:30:32 INFO - PROCESS | 3547 | __end_tp_report 13:30:32 INFO - PROCESS | 3547 | __start_cc_report 13:30:32 INFO - PROCESS | 3547 | _x_x_mozilla_cycle_collect,1065 13:30:32 INFO - PROCESS | 3547 | __end_cc_report 13:30:32 INFO - PROCESS | 3547 | __startTimestamp1452375032529__endTimestamp 13:30:32 INFO - PROCESS | 3547 | 13:30:32 INFO - PROCESS | 3547 | ------- Summary: start ------- 13:30:32 INFO - PROCESS | 3547 | Number of tests: 6 13:30:32 INFO - PROCESS | 3547 | 13:30:32 INFO - PROCESS | 3547 | [#0] dojo.html Cycles:165 Average:4452.25 Median:4626.10 stddev:565.22 (12.2%) stddev-sans-first:546.54 13:30:32 INFO - PROCESS | 3547 | Values: 2533.4 2631.5 2635.2 2647.4 2656.2 4324.2 4459.8 4496.4 4506.1 4507.1 4424.8 4461.2 4463.1 4492.6 4495.7 4217.7 4237.1 4290.1 4293.3 4310.0 89.5 4104.9 4193.4 4199.2 4321.5 4150.8 4158.3 4172.0 4173.0 4177.3 4095.1 4149.8 4167.7 4175.2 4203.2 4208.2 4212.5 4212.9 4220.9 4256.6 4477.0 4497.7 4511.0 4523.8 4571.0 4674.0 4759.5 4774.2 4797.5 4914.0 4886.8 4888.7 4892.9 4895.3 4896.9 4539.4 4544.6 4546.0 4579.0 4580.8 4768.6 4835.7 4900.4 4901.9 4973.1 4700.1 4745.5 4745.6 4755.2 4784.9 4809.7 4813.9 4818.5 4824.3 4861.1 4508.5 4666.9 4681.8 4766.3 4874.1 4780.0 4792.4 4796.4 4801.6 4821.1 4063.7 4065.7 4076.6 4087.3 4101.5 3479.9 3554.8 3592.5 3593.7 3606.4 4199.8 4206.3 4229.0 4235.7 4270.4 4884.4 4884.6 4887.6 4900.6 4935.0 4107.8 4122.0 4198.3 4201.5 4222.3 4356.7 4360.7 4361.5 4362.3 4367.9 4616.2 4632.3 4638.6 4647.7 4679.4 4642.9 4763.4 4774.9 4804.4 4871.8 4610.8 4622.2 4631.6 4642.7 4668.5 4807.5 4810.7 4813.1 4834.1 4874.2 4682.7 4799.4 4799.5 4809.0 4856.4 4712.8 4723.3 4728.4 4741.9 4757.6 4702.7 4715.3 4715.4 4732.2 4755.3 4470.6 4512.4 4575.7 4582.8 4626.1 4699.0 4737.5 4839.5 4893.9 4902.4 4661.3 4680.5 4682.7 4685.2 4733.4 13:30:32 INFO - PROCESS | 3547 | 13:30:32 INFO - PROCESS | 3547 | [#1] ext.html Cycles:180 Average:36896.59 Median:32265.69 stddev:62199.00 (192.8%) stddev-sans-first:62313.42 13:30:32 INFO - PROCESS | 3547 | Values: 489.3 495.8 509.9 519.9 520.3 24541.1 25051.9 25090.0 25107.6 25133.5 25173.1 25569.7 25595.0 32503.7 33334.0 7538.5 7692.1 7701.4 7702.2 7704.4 7442.9 7588.7 7589.4 7592.7 7597.1 6794.8 6996.5 6998.6 7543.8 9652.6 9414.3 9474.2 9539.9 9549.6 9554.7 9385.2 9528.8 9531.8 9532.8 9536.7 29439.9 30033.7 30125.4 30152.4 32722.5 2149.2 2183.4 2791.6 2803.3 3392.9 23916.2 24257.9 24282.0 24419.4 24632.1 3310.4 3310.9 3328.1 3331.4 3388.7 140051.0 140203.0 140307.0 140687.0 178064.0 44731.6 48068.0 48409.8 48461.3 48475.5 39520.8 39643.6 39666.0 39678.2 55269.0 12934.2 13056.7 13089.5 13123.0 13161.6 10040.2 10181.9 10192.1 10193.0 10194.5 16855.0 16860.9 16941.0 16983.4 17022.0 6780.2 7099.5 7131.3 7142.6 7196.8 785.8 847.3 848.7 863.5 908.6 25262.2 25569.9 25611.6 25714.5 25808.5 869.1 894.1 900.2 921.3 933.8 13223.0 13293.7 13419.0 13484.8 13532.3 256466.0 260420.0 261252.0 261317.0 261716.0 44209.8 44227.1 44428.6 44457.6 44468.0 1121.4 1156.8 1174.7 1186.7 1206.9 23809.8 25055.4 26255.6 28777.7 28790.7 35700.1 39843.8 39913.8 40410.4 40444.4 145893.0 148029.0 330049.0 344650.0 345218.0 27494.9 27573.3 27592.3 27611.4 27696.6 37813.2 38247.8 38438.8 38743.6 38972.6 31996.4 32957.7 32987.8 33582.0 33818.0 30698.0 32029.2 32502.2 32944.3 33556.5 29002.0 29068.3 29301.4 29332.0 29377.7 26227.3 28151.7 28501.3 28528.4 28535.0 22142.2 22361.2 22602.8 22649.3 22802.9 13:30:32 INFO - PROCESS | 3547 | 13:30:32 INFO - PROCESS | 3547 | [#2] jquery.html Cycles:180 Average:23934.01 Median:27526.59 stddev:74671.93 (271.3%) stddev-sans-first:74860.34 13:30:32 INFO - PROCESS | 3547 | Values: 311.7 322.4 323.5 329.9 339.9 11674.5 12115.4 15067.9 15506.1 15633.5 14060.7 14498.8 14697.6 15465.0 15468.3 4763.2 4869.6 4987.8 5062.8 5066.5 3296.7 3464.4 4901.4 5065.1 5273.4 5015.9 5259.1 5279.3 5298.0 5306.5 5087.6 5121.2 5126.1 5128.7 5134.4 4789.0 4909.0 4927.9 5192.8 5230.2 17717.3 18359.4 18370.8 18374.0 18695.7 1730.1 1771.6 1807.0 1816.5 1905.3 8946.9 9429.5 10018.6 12010.9 12375.9 1648.4 1715.9 1735.7 1765.4 1824.4 50037.2 51626.7 52019.3 52151.5 52920.0 9450.8 9642.7 9650.2 9663.2 9732.5 12470.3 12474.4 12487.8 12491.8 12495.2 6801.3 6928.2 6986.6 7006.0 7079.6 6619.7 6621.0 6678.0 6695.4 6703.9 4068.1 4145.6 4153.0 4183.7 4189.5 1555.1 1606.9 1628.0 1633.0 1686.8 763.4 807.5 819.5 826.2 925.9 11295.7 14736.9 14798.7 14998.8 15245.5 767.7 809.9 828.0 835.7 844.5 7965.2 8219.0 8310.0 8412.9 8736.4 449442.0 454064.7 454881.0 459127.0 467526.0 59521.4 61738.7 62964.4 63237.0 63256.7 1023.3 1056.3 1079.7 1085.9 1087.8 12564.7 13591.9 13821.1 13862.0 13940.0 29914.7 30240.8 30292.8 31121.5 31458.8 40276.6 40300.2 40314.8 40365.4 40427.8 6400.0 6482.5 6708.8 6716.3 6759.3 2999.6 3967.3 5712.7 9297.9 10020.7 8132.2 8500.7 8562.8 8602.8 8672.5 8518.2 8703.2 8944.1 9092.0 9148.0 5970.9 7994.8 8182.4 8298.0 8726.9 6496.9 6563.4 6567.0 6617.1 6781.4 7712.0 8458.5 8481.4 8528.3 8595.3 13:30:32 INFO - PROCESS | 3547 | 13:30:32 INFO - PROCESS | 3547 | [#3] mootools.html Cycles:180 Average:5124.74 Median:6137.10 stddev:2687.52 (43.8%) stddev-sans-first:2679.16 13:30:32 INFO - PROCESS | 3547 | Values: 1234.8 1361.4 1379.9 1493.7 1731.7 6090.6 6225.9 7087.1 7288.1 7324.0 7244.3 7264.6 7304.2 7326.0 7337.7 1742.8 1786.0 2122.2 2150.6 2154.7 2128.9 2183.5 2186.4 2188.0 2188.9 2129.4 2137.3 2173.9 2174.1 2178.1 2140.2 2147.1 2158.7 2159.6 2188.0 2130.2 2144.5 2151.7 2170.9 2173.5 7432.9 7469.1 7476.1 7477.4 7481.1 4245.3 4339.3 4368.8 4373.4 4374.1 2820.6 2822.4 2924.8 2926.5 2934.4 917.1 924.6 939.4 942.2 951.3 10050.1 10244.2 10245.2 10250.8 10260.6 4107.2 4133.8 4179.1 4197.0 4207.9 8839.7 8850.5 8859.7 8866.2 8870.6 4425.3 4459.5 4462.4 4462.5 4467.5 4006.5 4007.2 4007.6 4014.2 4022.5 3111.0 3167.3 3177.8 3390.7 3489.5 984.2 990.5 1139.9 1164.3 1173.8 1177.4 1184.3 1188.7 1206.3 1212.0 6675.5 6720.9 6733.1 6739.7 6746.5 978.3 981.3 997.6 1014.3 1014.6 5321.4 5358.6 5466.9 5468.3 5473.7 8810.0 8883.8 9102.5 9121.5 9128.4 8993.7 9084.6 9088.1 9117.0 9123.4 7002.3 7071.4 7074.1 7075.2 7079.5 6421.2 6510.5 6572.8 6578.5 6592.7 7720.1 7794.4 7805.4 8224.1 8226.5 8234.4 8437.7 8438.7 8553.7 8554.9 6414.9 6476.9 6483.7 6485.3 6486.4 6725.7 6823.4 6826.1 6843.2 6845.5 5602.8 5681.5 6326.5 6365.0 6370.6 6293.4 6301.3 6366.7 6379.4 6382.7 6419.1 6465.0 6465.2 6482.4 6498.5 5822.5 5985.5 6025.3 6039.4 6039.8 5796.5 6125.7 6132.4 6141.8 6142.3 13:30:32 INFO - PROCESS | 3547 | 13:30:32 INFO - PROCESS | 3547 | [#4] prototype.html Cycles:180 Average:4627.64 Median:5268.54 stddev:1355.32 (25.7%) stddev-sans-first:1319.86 13:30:32 INFO - PROCESS | 3547 | Values: 312.8 317.7 319.7 321.5 324.2 5158.8 5207.6 5323.9 5428.1 5468.4 5106.9 5262.1 5275.0 5279.0 5302.8 3902.8 4019.9 4131.7 4134.8 4140.8 4034.2 4125.2 4134.5 4138.8 4146.1 4086.1 4095.8 4099.2 4103.3 4103.8 4102.6 4103.0 4114.0 4115.8 4116.2 3599.5 3600.2 3600.6 3600.9 3604.7 4973.4 5086.8 5090.8 5106.6 5114.5 4688.1 4688.5 4698.8 4699.6 4703.4 5251.3 5531.2 5531.2 5533.8 5572.0 3773.5 3815.2 3826.0 3829.6 3873.7 5757.8 5804.3 5820.9 5837.4 5844.2 4008.7 4014.8 4018.1 4019.3 4024.0 3985.3 4069.3 4072.4 4077.6 4079.4 4658.2 4669.6 4671.4 4671.8 4678.1 5483.1 5534.3 5538.1 5553.6 5557.0 1431.8 1451.0 1451.1 1452.3 1452.6 980.0 986.2 986.3 986.4 1009.9 4841.8 4905.3 4910.1 4912.1 4917.2 5759.3 5761.7 5762.5 5765.3 5770.3 4902.1 4910.2 4913.9 4916.8 4919.1 3025.0 3111.7 3120.5 3127.4 3131.1 5486.5 5508.6 5512.3 5513.8 5514.8 5986.3 5991.5 5993.9 5995.1 5996.4 5499.0 5504.9 5505.6 5506.4 5512.6 5689.4 5832.5 5836.6 5839.9 5840.0 5420.5 5479.8 5555.1 5602.2 5608.2 5422.1 5428.9 5461.1 5461.3 5470.7 3980.0 4017.2 4017.7 4018.2 4021.3 5606.4 5776.9 5781.8 5783.8 5797.0 5583.8 5608.4 5612.8 5613.8 5614.2 5608.4 5637.9 5656.8 5667.4 5673.6 5370.9 5491.5 5499.3 5503.2 5505.3 5633.4 5642.5 5644.7 5646.8 5652.5 5502.3 5510.1 5515.3 5516.2 5516.9 13:30:32 INFO - PROCESS | 3547 | 13:30:32 INFO - PROCESS | 3547 | [#5] yui.html Cycles:180 Average:11644.65 Median:41327.88 stddev:12853.22 (31.1%) stddev-sans-first:12862.74 13:30:32 INFO - PROCESS | 3547 | Values: 646.9 679.9 744.9 747.8 767.4 10559.4 10685.7 10722.6 12450.6 12712.9 12289.1 12365.0 12376.0 12378.5 12379.3 609.7 617.0 760.8 767.5 780.3 774.5 777.2 780.7 782.0 782.1 800.9 808.2 810.6 811.7 811.7 621.4 631.0 800.0 819.4 819.7 594.0 601.8 603.4 603.8 603.9 10650.3 10652.8 10664.3 10707.8 10748.2 11185.2 11437.4 11467.4 11544.7 11585.4 8706.0 8723.2 8760.1 8776.4 8784.3 3154.3 3186.6 3215.5 3232.3 3241.2 37020.0 37146.6 37290.3 37598.6 37633.8 8854.6 9015.5 9031.8 9047.9 9070.1 15516.5 15649.3 15661.1 15702.8 15718.6 6271.8 6331.0 6333.3 6396.4 6415.0 3491.8 3516.5 3522.7 3549.9 3620.7 2596.8 2638.6 2639.0 2640.6 2644.4 479.9 488.7 490.2 492.7 495.0 501.9 549.8 577.6 581.0 599.7 7441.0 7445.6 7463.0 7579.3 7582.3 460.5 464.7 468.6 480.9 548.8 3280.2 3357.5 3417.1 3540.1 3580.9 45293.5 45900.0 45973.3 45973.8 45993.1 40695.8 40977.6 41055.0 41213.6 41442.2 37550.6 37646.6 38027.8 38253.8 38424.8 7149.6 7155.3 7960.9 8076.4 8093.6 27499.6 30130.0 30151.8 30174.2 30216.8 37990.2 38032.2 38339.6 38411.0 38457.4 9931.3 9964.0 10016.9 10185.4 10216.0 10713.6 10877.2 10936.3 10995.8 11075.2 10544.6 10599.7 10632.5 10813.1 10813.8 10054.3 10215.1 10235.5 10235.9 10625.0 9864.3 10129.7 10199.1 10281.8 10505.1 8233.4 8236.6 8433.6 8468.3 8720.3 8854.9 9005.1 9014.3 9038.2 9075.5 13:30:32 INFO - PROCESS | 3547 | -------- Summary: end -------- 13:30:32 INFO - PROCESS | 3547 | 13:30:33 INFO - TEST-INFO | 3547: exit 0 13:30:33 INFO - TEST-OK | dromaeo_css | took 1120818ms 13:30:33 INFO - TEST-START | kraken 13:30:33 INFO - operating with platform_type : linux_ 13:30:33 INFO - Initialising browser for kraken test... 13:30:33 INFO - TEST-INFO | started process 3742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprDCWFK/profile http://localhost:51603/getInfo.html) 13:30:38 INFO - PROCESS | 3742 | __metrics Screen width/height:1600/1200 13:30:38 INFO - PROCESS | 3742 | colorDepth:24 13:30:38 INFO - PROCESS | 3742 | Browser inner width/height: 1024/697 13:30:38 INFO - PROCESS | 3742 | __metrics 13:30:38 INFO - PROCESS | 3742 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:30:38 INFO - PROCESS | 3742 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:30:38 INFO - PROCESS | 3742 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 13:30:39 INFO - TEST-INFO | 3742: exit 0 13:30:39 INFO - Browser initialized. 13:30:39 INFO - Running cycle 1/1 for kraken test... 13:30:39 INFO - TEST-INFO | started process 3826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprDCWFK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:30:51 INFO - PROCESS | 3826 | RSS: Main: 147066880 13:30:51 INFO - PROCESS | 3826 | 13:30:53 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51603/tests/kraken/driver.html?testName=audio-beat-detection) 13:30:54 INFO - PROCESS | 3826 | RSS: Main: 186339328 13:30:54 INFO - PROCESS | 3826 | 13:30:57 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51603/tests/kraken/driver.html?testName=audio-dft) 13:30:57 INFO - PROCESS | 3826 | RSS: Main: 175181824 13:30:57 INFO - PROCESS | 3826 | 13:31:00 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51603/tests/kraken/driver.html?testName=audio-fft) 13:31:01 INFO - PROCESS | 3826 | RSS: Main: 160894976 13:31:01 INFO - PROCESS | 3826 | 13:31:03 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51603/tests/kraken/driver.html?testName=audio-oscillator) 13:31:04 INFO - PROCESS | 3826 | RSS: Main: 162451456 13:31:04 INFO - PROCESS | 3826 | 13:31:06 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:31:06 INFO - PROCESS | 3826 | RSS: Main: 164409344 13:31:06 INFO - PROCESS | 3826 | 13:31:09 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51603/tests/kraken/driver.html?testName=imaging-darkroom) 13:31:10 INFO - PROCESS | 3826 | RSS: Main: 165371904 13:31:10 INFO - PROCESS | 3826 | 13:31:13 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51603/tests/kraken/driver.html?testName=imaging-desaturate) 13:31:14 INFO - PROCESS | 3826 | RSS: Main: 164585472 13:31:14 INFO - PROCESS | 3826 | 13:31:17 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51603/tests/kraken/driver.html?testName=json-parse-financial) 13:31:17 INFO - PROCESS | 3826 | RSS: Main: 165638144 13:31:17 INFO - PROCESS | 3826 | 13:31:19 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:31:20 INFO - PROCESS | 3826 | RSS: Main: 174391296 13:31:20 INFO - PROCESS | 3826 | 13:31:21 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51603/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:31:22 INFO - PROCESS | 3826 | RSS: Main: 172638208 13:31:22 INFO - PROCESS | 3826 | 13:31:24 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:31:25 INFO - PROCESS | 3826 | RSS: Main: 187502592 13:31:25 INFO - PROCESS | 3826 | 13:31:27 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:31:28 INFO - PROCESS | 3826 | RSS: Main: 189816832 13:31:28 INFO - PROCESS | 3826 | 13:31:30 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:31:31 INFO - PROCESS | 3826 | RSS: Main: 190144512 13:31:31 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:51603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51603/tests/kraken/driver.html?testName=ai-astar) 13:31:33 INFO - PROCESS | 3826 | RSS: Main: 247042048 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | __start_tp_report 13:31:33 INFO - PROCESS | 3826 | _x_x_mozilla_page_load 13:31:33 INFO - PROCESS | 3826 | _x_x_mozilla_page_load_details 13:31:33 INFO - PROCESS | 3826 | |i|pagename|runs| 13:31:33 INFO - PROCESS | 3826 | |0;ai-astar;112;114;108;114;114;114;102;114;115;109 13:31:33 INFO - PROCESS | 3826 | |1;audio-beat-detection;156;129;160;162;129;158;154;129;175;135 13:31:33 INFO - PROCESS | 3826 | |2;audio-dft;162;160;161;162;163;163;163;163;168;162 13:31:33 INFO - PROCESS | 3826 | |3;audio-fft;74;74;83;90;74;72;72;105;92;74 13:31:33 INFO - PROCESS | 3826 | |4;audio-oscillator;98;96;139;97;97;97;139;96;96;136 13:31:33 INFO - PROCESS | 3826 | |5;imaging-gaussian-blur;109;109;109;109;110;110;110;109;110;110 13:31:33 INFO - PROCESS | 3826 | |6;imaging-darkroom;147;146;146;147;146;147;147;149;148;146 13:31:33 INFO - PROCESS | 3826 | |7;imaging-desaturate;96;95;95;96;96;97;96;96;96;97 13:31:33 INFO - PROCESS | 3826 | |8;json-parse-financial;72;70;72;72;71;71;72;81;69;70 13:31:33 INFO - PROCESS | 3826 | |9;json-stringify-tinderbox;67;68;68;68;67;67;68;68;68;68 13:31:33 INFO - PROCESS | 3826 | |10;stanford-crypto-aes;83;83;84;88;86;86;86;84;85;85 13:31:33 INFO - PROCESS | 3826 | |11;stanford-crypto-ccm;135;121;123;119;128;125;121;121;122;122 13:31:33 INFO - PROCESS | 3826 | |12;stanford-crypto-pbkdf2;141;146;150;150;149;137;150;148;148;139 13:31:33 INFO - PROCESS | 3826 | |13;stanford-crypto-sha256-iterative;74;74;74;71;72;72;70;71;70;72 13:31:33 INFO - PROCESS | 3826 | __end_tp_report 13:31:33 INFO - PROCESS | 3826 | __start_cc_report 13:31:33 INFO - PROCESS | 3826 | _x_x_mozilla_cycle_collect,1000 13:31:33 INFO - PROCESS | 3826 | __end_cc_report 13:31:33 INFO - PROCESS | 3826 | __startTimestamp1452375093582__endTimestamp 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | ------- Summary: start ------- 13:31:33 INFO - PROCESS | 3826 | Number of tests: 14 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#0] ai-astar Cycles:10 Average:111.60 Median:114.00 stddev:4.12 (3.6%) stddev-sans-first:4.36 13:31:33 INFO - PROCESS | 3826 | Values: 112.0 114.0 108.0 114.0 114.0 114.0 102.0 114.0 115.0 109.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:157.00 stddev:16.72 (10.6%) stddev-sans-first:17.52 13:31:33 INFO - PROCESS | 3826 | Values: 156.0 129.0 160.0 162.0 129.0 158.0 154.0 129.0 175.0 135.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:2.11 (1.3%) stddev-sans-first:2.22 13:31:33 INFO - PROCESS | 3826 | Values: 162.0 160.0 161.0 162.0 163.0 163.0 163.0 163.0 168.0 162.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:11.25 (15.2%) stddev-sans-first:11.65 13:31:33 INFO - PROCESS | 3826 | Values: 74.0 74.0 83.0 90.0 74.0 72.0 72.0 105.0 92.0 74.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.50 stddev:19.97 (20.7%) stddev-sans-first:20.77 13:31:33 INFO - PROCESS | 3826 | Values: 98.0 96.0 139.0 97.0 97.0 97.0 139.0 96.0 96.0 136.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:31:33 INFO - PROCESS | 3826 | Values: 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 110.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 13:31:33 INFO - PROCESS | 3826 | Values: 147.0 146.0 146.0 147.0 146.0 147.0 147.0 149.0 148.0 146.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 13:31:33 INFO - PROCESS | 3826 | Values: 96.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#8] json-parse-financial Cycles:10 Average:72.00 Median:72.00 stddev:3.33 (4.6%) stddev-sans-first:3.54 13:31:33 INFO - PROCESS | 3826 | Values: 72.0 70.0 72.0 72.0 71.0 71.0 72.0 81.0 69.0 70.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 13:31:33 INFO - PROCESS | 3826 | Values: 67.0 68.0 68.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.50 stddev:1.56 (1.8%) stddev-sans-first:1.48 13:31:33 INFO - PROCESS | 3826 | Values: 83.0 83.0 84.0 88.0 86.0 86.0 86.0 84.0 85.0 85.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:122.50 stddev:4.69 (3.8%) stddev-sans-first:2.65 13:31:33 INFO - PROCESS | 3826 | Values: 135.0 121.0 123.0 119.0 128.0 125.0 121.0 121.0 122.0 122.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:148.50 stddev:4.94 (3.3%) stddev-sans-first:4.92 13:31:33 INFO - PROCESS | 3826 | Values: 141.0 146.0 150.0 150.0 149.0 137.0 150.0 148.0 148.0 139.0 13:31:33 INFO - PROCESS | 3826 | 13:31:33 INFO - PROCESS | 3826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.56 (2.2%) stddev-sans-first:1.48 13:31:33 INFO - PROCESS | 3826 | Values: 74.0 74.0 74.0 71.0 72.0 72.0 70.0 71.0 70.0 72.0 13:31:33 INFO - PROCESS | 3826 | -------- Summary: end -------- 13:31:33 INFO - PROCESS | 3826 | 13:31:34 INFO - TEST-INFO | 3826: exit 0 13:31:34 INFO - TEST-OK | kraken | took 61270ms 13:31:34 INFO - TEST-START | v8_7 13:31:34 INFO - operating with platform_type : linux_ 13:31:34 INFO - Initialising browser for v8_7 test... 13:31:34 INFO - TEST-INFO | started process 4075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIA1LUZ/profile http://localhost:51603/getInfo.html) 13:31:39 INFO - PROCESS | 4075 | __metrics Screen width/height:1600/1200 13:31:39 INFO - PROCESS | 4075 | colorDepth:24 13:31:39 INFO - PROCESS | 4075 | Browser inner width/height: 1024/697 13:31:39 INFO - PROCESS | 4075 | __metrics 13:31:39 INFO - PROCESS | 4075 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:31:39 INFO - PROCESS | 4075 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:31:40 INFO - TEST-INFO | 4075: exit 0 13:31:40 INFO - Browser initialized. 13:31:40 INFO - Running cycle 1/1 for v8_7 test... 13:31:40 INFO - TEST-INFO | started process 4156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIA1LUZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:52 INFO - PROCESS | 4156 | RSS: Main: 149364736 13:31:52 INFO - PROCESS | 4156 | 13:32:14 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:51603/tests/v8_7/run.html (next: http://localhost:51603/tests/v8_7/run.html) 13:32:15 INFO - PROCESS | 4156 | RSS: Main: 448905216 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | __start_tp_report 13:32:15 INFO - PROCESS | 4156 | _x_x_mozilla_page_load 13:32:15 INFO - PROCESS | 4156 | _x_x_mozilla_page_load_details 13:32:15 INFO - PROCESS | 4156 | |i|pagename|runs| 13:32:15 INFO - PROCESS | 4156 | |0;Richards;166.9449081803005 13:32:15 INFO - PROCESS | 4156 | |1;DeltaBlue;187.65246762994934 13:32:15 INFO - PROCESS | 4156 | |2;Encrypt;277.9321845469705 13:32:15 INFO - PROCESS | 4156 | |3;Decrypt;5263.1578947368425 13:32:15 INFO - PROCESS | 4156 | |4;RayTrace;2022.2222222222222 13:32:15 INFO - PROCESS | 4156 | |5;Earley;810.3727714748784 13:32:15 INFO - PROCESS | 4156 | |6;Boyer;12219.512195121952 13:32:15 INFO - PROCESS | 4156 | |7;RegExp;44000 13:32:15 INFO - PROCESS | 4156 | |8;Splay;620.4334365325077 13:32:15 INFO - PROCESS | 4156 | |9;NavierStokes;4826.923076923077 13:32:15 INFO - PROCESS | 4156 | __end_tp_report 13:32:15 INFO - PROCESS | 4156 | __startTimestamp1452375135144__endTimestamp 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | ------- Summary: start ------- 13:32:15 INFO - PROCESS | 4156 | Number of tests: 10 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#0] Richards Cycles:1 Average:166.94 Median:166.94 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 166.9 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#1] DeltaBlue Cycles:1 Average:187.65 Median:187.65 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 187.7 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 277.9 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 5263.2 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#4] RayTrace Cycles:1 Average:2022.22 Median:2022.22 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 2022.2 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#5] Earley Cycles:1 Average:810.37 Median:810.37 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 810.4 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 12219.5 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#7] RegExp Cycles:1 Average:44000.00 Median:44000.00 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 44000.0 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#8] Splay Cycles:1 Average:620.43 Median:620.43 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 620.4 13:32:15 INFO - PROCESS | 4156 | 13:32:15 INFO - PROCESS | 4156 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 13:32:15 INFO - PROCESS | 4156 | Values: 4826.9 13:32:15 INFO - PROCESS | 4156 | -------- Summary: end -------- 13:32:15 INFO - PROCESS | 4156 | 13:32:16 INFO - TEST-INFO | 4156: exit 0 13:32:16 INFO - TEST-OK | v8_7 | took 41565ms 13:32:16 INFO - SUITE-END | took 1223s 13:32:16 INFO - Completed test suite (00:20:24) 13:32:16 INFO - Working with test: dromaeo_css 13:32:16 INFO - Generating results file: dromaeo_css 13:32:16 INFO - Working with test: kraken 13:32:16 INFO - Generating results file: kraken 13:32:16 INFO - javascript benchmark 13:32:16 INFO - Working with test: v8_7 13:32:16 INFO - Generating results file: v8_7 13:32:16 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:32:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 13:32:16 INFO - process_Request line: dromaeo_css 6049.15 graph.html#tests=[[72,94,35]] 13:32:16 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:32:16 INFO - process_Request line: kraken 1531.70 graph.html#tests=[[232,94,35]] 13:32:16 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:32:16 INFO - process_Request line: v8_7 18701.12 graph.html#tests=[[230,94,35]] 13:32:16 INFO - RETURN: dromaeo_css: 6049.15 13:32:16 INFO - RETURN: kraken: 1531.70 13:32:16 INFO - RETURN: v8_7: 18701.12 13:32:16 INFO - javascript benchmark 13:32:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2533.404649907272, 2631.513170063537, 2635.2489540480965, 2647.444036752282, 2656.242970753335, 4324.200022995748, 4459.843905463309, 4496.437945256839, 4506.143832671794, 4507.05351876106, 4424.823007079713, 4461.219286624844, 4463.062756821071, 4492.618127459162, 4495.662825288108, 4217.704760666755, 4237.08902585944, 4290.077633308838, 4293.2701440755145, 4310.0, 89.45315871658262, 4104.917901641966, 4193.412922190896, 4199.223143718422, 4321.503027151886, 4150.775521221247, 4158.251514727348, 4172.040430700956, 4173.019340454991, 4177.289860723684, 4095.1400205956784, 4149.83400663973, 4167.708260421772, 4175.206710724952, 4203.159368126387, 4208.200441916026, 4212.473440819897, 4212.87361379156, 4220.936685949713, 4256.574342565718, 4476.977615111936, 4497.707649002804, 4511.0, 4523.796429160663, 4570.977145114286, 4674.018456124218, 4759.452662943737, 4774.212254977924, 4797.496262892381, 4914.0, 4886.821025784077, 4888.657793954425, 4892.926606100911, 4895.290182923492, 4896.877578060541, 4539.387182730289, 4544.568266014757, 4545.977270113662, 4578.9771051144535, 4580.839670611546, 4768.61851051915, 4835.661503694778, 4900.387451568554, 4901.877453063702, 4973.104841128632, 4700.08348372071, 4745.477997420281, 4745.5966242869745, 4755.191617425046, 4784.928226076611, 4809.687370320918, 4813.927791083137, 4818.518148185153, 4824.276358546246, 4861.1006963711825, 4508.526604706459, 4666.929996050062, 4681.836135735233, 4766.308885211694, 4874.098291816025, 4779.976100119547, 4792.400949881265, 4796.35249241348, 4801.615870730333, 4821.059893320768, 4063.7358571692744, 4065.6950728695465, 4076.612721791425, 4087.325591277406, 4101.466809314829, 3479.860805567749, 3554.751167418256, 3592.515010473605, 3593.6945359644724, 3606.404943184345, 4199.769012704331, 4206.284931561642, 4229.0, 4235.703500754979, 4270.402143699885, 4884.389451318585, 4884.609231261491, 4887.560119589183, 4900.607951363882, 4934.975325123423, 4107.753534787922, 4121.9587804122175, 4198.349255865346, 4201.495820501498, 4222.3244280914905, 4356.716813407118, 4360.738355698668, 4361.454818147731, 4362.258416069276, 4367.868963931087, 4616.215243408561, 4632.328312394751, 4638.605718513897, 4647.744374059459, 4679.368285281444, 4642.907141857077, 4763.428388593391, 4774.880627984328, 4804.399450068741, 4871.8294859681155, 4610.769461526843, 4622.1911165545225, 4631.583157515705, 4642.675012749075, 4668.533146685304, 4807.471178170328, 4810.687305325143, 4813.085513752376, 4834.057358814997, 4874.195757699939, 4682.672212945061, 4799.352087468147, 4799.472058073539, 4809.038192361471, 4856.441509226484, 4712.835050773207, 4723.267893476516, 4728.385309909827, 4741.857744267678, 4757.619390448686, 4702.694324868872, 4715.316279139437, 4715.41057367829, 4732.219183834629, 4755.334253204624, 4470.642348612038, 4512.368268442487, 4575.725456472623, 4582.839600614096, 4626.0979109073405, 4699.0, 4737.502562231054, 4839.516048395132, 4893.877653058702, 4902.436219834622, 4661.277501987197, 4680.531946805292, 4682.695624784378, 4685.226937555265, 4733.431988161443], "unit": "score", "name": "dojo.html", "value": 4420.636954670351}, {"lowerIsBetter": false, "replicates": [489.2758717098696, 495.8066354121891, 509.9107656160172, 519.9480051994799, 520.3131865936963, 24541.141060062902, 25051.874740626296, 25090.0, 25107.62338564923, 25133.497330053433, 25173.118940837074, 25569.74430255697, 25595.0, 32503.67496325036, 33334.0, 7538.47230693853, 7692.115406728214, 7701.422393320496, 7702.191269916662, 7704.422168337369, 7442.851142977137, 7588.734394296201, 7589.392848572129, 7592.734254301101, 7597.050368703912, 6794.830129246759, 6996.510244282902, 6998.615076170809, 7543.7736867894055, 9652.613895444174, 9414.293927955396, 9474.242060635133, 9539.90460095404, 9549.61801527938, 9554.713358599183, 9385.249180065579, 9528.761780955532, 9531.809363812754, 9532.809343813155, 9536.666216682383, 29439.85280073586, 30033.69966300353, 30125.397492050255, 30152.396952060837, 32722.509162362585, 2149.161826887515, 2183.366823621148, 2791.5812628105746, 2803.3272014716526, 3392.915177120567, 23916.162934297216, 24257.878710606336, 24282.0, 24419.38951526226, 24632.13787517428, 3310.4372256716415, 3310.940499040308, 3328.084776686431, 3331.3503866745996, 3388.6611338866164, 140051.0, 140203.0, 140307.0, 140687.0, 178064.0, 44731.552684472736, 48068.0, 48409.757951210726, 48461.27308090311, 48475.515244847804, 39520.80239598841, 39643.60356396457, 39666.0, 39678.20643587112, 55269.0, 12934.159279646981, 13056.673583160307, 13089.541866034642, 13123.015773817002, 13161.60515184546, 10040.246981476419, 10181.898181018096, 10192.082712555757, 10193.0, 10194.541245643964, 16855.0, 16860.91569542169, 16941.0, 16983.405580804614, 17022.0, 6780.1524809398825, 7099.467539934525, 7131.322524360177, 7142.607156606333, 7196.820079498055, 785.8349746553173, 847.3348421489102, 848.6520526584194, 863.4560227056913, 908.5775114571624, 25262.242132736046, 25569.8721506395, 25611.61582576263, 25714.485710286062, 25808.48383032329, 869.0527325215545, 894.141624040928, 900.1898291537537, 921.3366376209119, 933.780561568031, 13223.0, 13293.73412531744, 13419.0, 13484.797728034087, 13532.32338383077, 256466.0, 260420.0, 261252.0, 261317.0, 261716.0, 44209.778951105036, 44227.11545769066, 44428.55571444244, 44457.555424445345, 44468.0, 1121.4168632311316, 1156.8033434316187, 1174.6945794093426, 1186.6618013866007, 1206.927584344942, 23809.761902381448, 25055.373615659755, 26255.60616590791, 28777.712222877504, 28790.712092878803, 35700.107497311736, 39843.800780997066, 39913.80043099766, 40410.39384409178, 40444.393334099426, 145893.0, 148029.0, 330049.0, 344650.0, 345218.0, 27494.862525687244, 27573.31066723348, 27592.310192245353, 27611.44777104487, 27696.584551231346, 37813.243735125696, 38247.80876095602, 38438.80780596191, 38743.612563875125, 38972.6102738969, 31996.360072798878, 32957.67042329546, 32987.835060824546, 33582.0, 33818.0, 30698.0, 32029.199270017503, 32502.187445314055, 32944.34111317808, 33556.496652549744, 29002.0, 29068.27329316784, 29301.41397172087, 29332.0, 29377.706222937497, 26227.344316392242, 28151.71848281491, 28501.287467812643, 28528.42943141084, 28535.0, 22142.22502212415, 22361.217357392412, 22602.773972260067, 22649.320520384415, 22802.885985569967], "unit": "score", "name": "ext.html", "value": 15612.976409085884}, {"lowerIsBetter": false, "replicates": [311.6509509349529, 322.4437844717862, 323.5486496337609, 329.8779451602907, 339.87934283329434, 11674.474648640811, 12115.394230288495, 15067.924660376697, 15506.147161906105, 15633.530994070168, 14060.718785624282, 14498.767604753608, 14697.632559186026, 15465.0, 15468.303926323315, 4763.214069678499, 4869.561739443449, 4987.8254261100865, 5062.848114556551, 5066.544011039005, 3296.6868147525947, 3464.3764122457947, 4901.387326584177, 5065.088284108859, 5273.4199238083975, 5015.924761128586, 5259.053370393328, 5279.2872962150195, 5298.0, 5306.548943339821, 5087.643864929457, 5121.2318152277085, 5126.102931986925, 5128.743457852813, 5134.435212126682, 4788.9521104788855, 4909.0, 4927.876803079916, 5192.844214673566, 5230.241614965808, 17717.291308347652, 18359.449216523524, 18370.816291837044, 18374.0, 18695.71956420641, 1730.1176400035947, 1771.5836778357075, 1807.0242069282572, 1816.4732227654097, 1905.3140869287045, 8946.86579701305, 9429.528523573863, 10018.59925602975, 12010.879891201064, 12375.938120309342, 1648.3900956645998, 1715.8627309815186, 1735.6615459985182, 1765.4262364731385, 1824.3797108982876, 50037.24944125841, 51626.74186629043, 52019.2881288525, 52151.47848521542, 52920.0, 9450.810983780424, 9642.71071867845, 9650.227981761442, 9663.178629816544, 9732.513374331254, 12470.314132722606, 12474.376281185905, 12487.812682809765, 12491.750164996649, 12495.187812792321, 6801.2858649841055, 6928.237893831674, 6986.615736134459, 7005.964970175117, 7079.646017699094, 6619.735210591619, 6620.966895165589, 6677.966610166918, 6695.363940425652, 6703.865922681616, 4068.105016896278, 4145.626893579592, 4153.0, 4183.707140500136, 4189.518205406417, 1555.1368990210315, 1606.9276882540314, 1627.983720162807, 1632.9755053674205, 1686.7807185065863, 763.4236151705538, 807.4690890739437, 819.4632515702106, 826.1985873702499, 925.9444233573731, 11295.661130165943, 14736.852631473763, 14798.704025919422, 14998.775018374734, 15245.542633721006, 767.6622286194057, 809.9433039687283, 827.9917200828035, 835.7116794705817, 844.4933040175845, 7965.163657815961, 8218.958905205436, 8309.95845020771, 8412.915870841336, 8736.388452808242, 449442.0, 454064.6748260131, 454881.0, 459127.0, 467526.0, 59521.40478595245, 61738.69130654318, 62964.370356296764, 63237.0, 63256.68371658112, 1023.2632504596678, 1056.2606175676904, 1079.7205311705497, 1085.8968398002178, 1087.8259478483405, 12564.685882853002, 13591.932040339734, 13821.101628394123, 13862.0, 13940.0, 29914.70085299119, 30240.84879575588, 30292.84853575718, 31121.533177002817, 31458.842705786323, 40276.597234027286, 40300.178987470594, 40314.798426007685, 40365.39451908165, 40427.797861011684, 6399.968000159969, 6482.481401487776, 6708.765193218214, 6716.261211266855, 6759.290274521104, 2999.550067489894, 3967.26605577969, 5712.742926568398, 9297.907020929704, 10020.749481263027, 8132.186781322057, 8500.70247541333, 8562.828743425222, 8602.82794344097, 8672.479651220947, 8518.190771876662, 8703.173198546128, 8944.105589441004, 9092.0, 9147.954260228656, 5970.880582388415, 7994.760157195294, 8182.386321026066, 8297.95851020741, 8726.865507483986, 6496.902546461902, 6563.409293163447, 6566.967165164144, 6617.139771829631, 6781.355771201728, 7712.0, 8458.450200736932, 8481.363897707573, 8528.251708399886, 8595.312375009858], "unit": "score", "name": "jquery.html", "value": 7318.124094033089}, {"lowerIsBetter": false, "replicates": [1234.8086046662759, 1361.4145917255582, 1379.9034067615269, 1493.7161939231546, 1731.6536692661464, 6090.5736598438125, 6225.937740622592, 7087.1495420549545, 7288.125424949014, 7323.963380183105, 7244.311790379906, 7264.6367681615975, 7304.196538380774, 7326.0, 7337.706491740324, 1742.8431441170292, 1786.0355408079622, 2122.246602456129, 2150.6451435513122, 2154.741431028279, 2128.925487607934, 2183.4977955070344, 2186.431527802775, 2187.9562408751817, 2188.912443502258, 2129.37183530858, 2137.2733270687963, 2173.8913054347217, 2174.141214220382, 2178.117862265785, 2140.154638917634, 2147.1196809308185, 2158.6761985702115, 2159.6112699714045, 2188.0372636040092, 2130.1692339987417, 2144.485323522359, 2151.7202763640626, 2170.913163473459, 2173.521825198454, 7432.85134297311, 7469.103707555074, 7476.102867655916, 7477.439192060618, 7481.139668938087, 4245.299525578276, 4339.349097635349, 4368.759718215497, 4373.409589705413, 4374.059577190919, 2820.5910143029146, 2822.3649678822308, 2924.8391338476376, 2926.4732348177317, 2934.3691106412225, 917.1149840404042, 924.5608336040394, 939.3800091939287, 942.2273735536862, 951.3388195204336, 10050.145737612313, 10244.231682623758, 10245.231607629457, 10250.794984100276, 10260.589576416935, 4107.178564287155, 4133.751974881517, 4179.101493178981, 4196.958030419718, 4207.852725154605, 8839.734807955772, 8850.513221772864, 8859.689910853089, 8866.202041816268, 8870.600822962982, 4425.291953287523, 4459.487158976694, 4462.419885414875, 4462.509123996358, 4467.486239082482, 4006.4991876015497, 4007.1785284016705, 4007.579204183519, 4014.1971605678395, 4022.4971878515184, 3110.9533356999664, 3167.2715275486307, 3177.777555571134, 3390.677885600864, 3489.546358973368, 984.1978787288338, 990.5096976996289, 1139.9487023083982, 1164.336328292865, 1173.8004539228352, 1177.4289469607234, 1184.2894263441865, 1188.6612315490045, 1206.252123683322, 1212.018265205169, 6675.532712710161, 6720.932790672128, 6733.091032710619, 6739.730410783612, 6746.460283177334, 978.280963491833, 981.2885657897967, 997.6059456514781, 1014.2697257974247, 1014.6043043213152, 5321.361436627552, 5358.5981051421295, 5466.945330546723, 5468.343798744176, 5473.698946557898, 8810.0, 8883.822323553622, 9102.453852768855, 9121.543922803834, 9128.361014728906, 8993.730188094367, 9084.591193396182, 9088.136627020422, 9116.954415227881, 9123.36136470454, 7002.299770022957, 7071.398931090812, 7074.115735533059, 7075.150981882207, 7079.548692518021, 6421.229452465734, 6510.511711621552, 6572.76995305162, 6578.539502234989, 6592.70332835014, 7720.073591169095, 7794.415418843496, 7805.375569954504, 8224.136465671018, 8226.547539885363, 8234.382421318545, 8437.746867593982, 8438.704645337384, 8553.700620478503, 8554.91445085566, 6414.871702566016, 6476.935230647821, 6483.708233129426, 6485.254195767548, 6486.37840539865, 6725.725032168741, 6823.38589526945, 6826.112605361272, 6843.178818541807, 6845.520813543004, 5602.803901863415, 5681.488666020078, 6326.4622507087415, 6365.0, 6370.617762934239, 6293.433590976834, 6301.306856245717, 6366.745330186741, 6379.393957574023, 6382.680865956777, 6419.133416988647, 6464.967675161594, 6465.191851018622, 6482.384173503509, 6498.545101842826, 5822.475977162076, 5985.491233245223, 6025.307089684742, 6039.365866583946, 6039.818805435844, 5796.507296879812, 6125.663088529996, 6132.448079672851, 6141.7543298267565, 6142.293636231891], "unit": "score", "name": "mootools.html", "value": 4205.327671828354}, {"lowerIsBetter": false, "replicates": [312.77323940143395, 317.66169029983064, 319.72663372816237, 321.5369867390958, 324.22995385958365, 5158.7936482540745, 5207.583393328534, 5323.9467605323935, 5428.050091234038, 5468.3711373192045, 5106.872328191787, 5262.105442074847, 5274.973625131878, 5278.996990571789, 5302.840914772553, 3902.843886244561, 4019.8995025124314, 4131.690123240754, 4134.793260336986, 4140.792960351985, 4034.23349563582, 4125.154343359604, 4134.52452967908, 4138.8137533810905, 4146.129312844307, 4086.1419101988618, 4095.75425474471, 4099.221147981889, 4103.261412945669, 4103.835846566134, 4102.630763231294, 4102.958970410303, 4113.979430102845, 4115.814788334532, 4116.176764647083, 3599.4960705501253, 3600.1899572596217, 3600.6399360064047, 3600.9279814403567, 3604.6936010439144, 4973.4280557735965, 5086.821961231339, 5090.821821236276, 5106.64253502255, 5114.488551144893, 4688.062387522475, 4688.507706690816, 4698.835540756091, 4699.577038066591, 4703.435587729495, 5251.317328747276, 5531.170324451325, 5531.225628412026, 5533.750981205855, 5571.9721401392735, 3773.52830896138, 3815.1606646537716, 3826.043489127718, 3829.5787463379006, 3873.748206366577, 5757.769689212427, 5804.332501762309, 5820.912686309709, 5837.416258374171, 5844.211031510734, 4008.6793056555407, 4014.7791871446766, 4018.07584255617, 4019.2765302245875, 4024.0342317843506, 3985.3025720499377, 4069.308217603015, 4072.4095006224525, 4077.6330130288416, 4079.4288799568085, 4658.231391820379, 4669.60308373792, 4671.416072990876, 4671.813127474863, 4678.111158879802, 5483.067878460672, 5534.335879694462, 5538.141588053858, 5553.6390134641115, 5557.0, 1431.77807439847, 1451.0060608483222, 1451.1293224065687, 1452.3101526774697, 1452.6077958951234, 979.9559019844124, 986.1529316611549, 986.2750878104588, 986.4229425785995, 1009.8838633557089, 4841.789552611847, 4905.264210368473, 4910.140725373046, 4912.140375434285, 4917.164082106051, 5759.2512973313205, 5761.683107429131, 5762.4525670061275, 5765.3369862465515, 5770.307563092456, 4902.142125128088, 4910.189818679949, 4913.877153071202, 4916.803327866917, 4919.139150648693, 3024.9697503024686, 3111.7355024823146, 3120.469520181575, 3127.390158918989, 3131.1076343242066, 5486.478784515464, 5508.614396992172, 5512.310961129859, 5513.8345849624575, 5514.779408823602, 5986.2517185351835, 5991.460768530853, 5993.910091348634, 5995.100734889801, 5996.430339117776, 5499.0, 5504.862378440571, 5505.614606977553, 5506.449355064461, 5512.614117011771, 5689.402612725604, 5832.475077243069, 5836.591438599257, 5839.883202336015, 5840.036393994943, 5420.4850539198715, 5479.75341109659, 5555.0834112371, 5602.215689803512, 5608.242887210337, 5422.05114105038, 5428.864278393072, 5461.071617825059, 5461.2627295316215, 5470.699111548903, 3980.024893901013, 4017.2367250222364, 4017.6584990276156, 4018.216447792652, 4021.2962731522452, 5606.355269144101, 5776.913346299725, 5781.82654520365, 5783.797567085132, 5796.971015144897, 5583.776648933997, 5608.355039170548, 5612.803551875665, 5613.803516876889, 5614.24207731951, 5608.439156084522, 5637.887242255214, 5656.830295091154, 5667.3765885753355, 5673.602847800615, 5370.919436208382, 5491.478309560585, 5499.285092937893, 5503.2020357048805, 5505.256790333254, 5633.436656334334, 5642.520385767256, 5644.717764111861, 5646.774129034792, 5652.519535839499, 5502.339719233718, 5510.090835012178, 5515.310586176728, 5516.200150978006, 5516.889662206813], "unit": "score", "name": "prototype.html", "value": 4198.68049104346}, {"lowerIsBetter": false, "replicates": [646.9320721324261, 679.9155347221182, 744.8510297940413, 747.835476195237, 767.3784234769837, 10559.41923194224, 10685.732856678587, 10722.624708135218, 12450.564230251943, 12712.872871271284, 12289.139760216765, 12365.0, 12376.0, 12378.504859805596, 12379.25724456531, 609.7012463892682, 617.0466629058116, 760.7831767946136, 767.5087943716027, 780.2509590792846, 774.4927072767347, 777.2460713108276, 780.6682160081971, 782.0, 782.077148964222, 800.8798680197958, 808.2321794295414, 810.5987536169575, 811.7240138352959, 811.7240138352959, 621.3599992008238, 631.0093153748594, 799.9800004999863, 819.3854609043218, 819.7417813388763, 594.0, 601.7923816283375, 603.3513972479558, 603.7796204385412, 603.8701679139007, 10650.307729997525, 10652.840207396895, 10664.253502254845, 10707.785844283071, 10748.247622666417, 11185.217034807567, 11437.370944598044, 11467.426628668616, 11544.653660390202, 11585.420728963518, 8705.956470217609, 8723.171298726611, 8760.080191579857, 8776.429532080458, 8784.34117441188, 3154.2587491939375, 3186.6176058873084, 3215.485522316418, 3232.305054413289, 3241.205904553376, 37020.0, 37146.62853371459, 37290.25419491622, 37598.62401376006, 37633.81183094067, 8854.557272136368, 9015.549222538846, 9031.819363612822, 9047.864282035775, 9070.092990700878, 15516.456924007605, 15649.29578168985, 15661.060336379855, 15702.76445853313, 15718.607034823992, 6271.811845644638, 6331.0, 6333.334999825044, 6396.360363963567, 6415.0, 3491.773034752733, 3516.542849429609, 3522.682958533744, 3549.9290014200087, 3620.728445366608, 2596.818222724429, 2638.643783089297, 2639.0367515856574, 2640.564306889342, 2644.3917898883365, 479.92321228603953, 488.726313264573, 490.2181021271067, 492.6748346091562, 495.03468236938113, 501.86198795331575, 549.793827314757, 577.6158854361802, 580.9796657116981, 599.6941559804532, 7440.962795185989, 7445.5532668039, 7463.029806125278, 7579.279968402993, 7582.279683430065, 460.45436158152694, 464.71884509871717, 468.57359802579487, 480.92545655423464, 548.8079172289747, 3280.2291461506525, 3357.462805951036, 3417.1457135716073, 3540.0795793093466, 3580.874669386559, 45293.54706452959, 45900.0, 45973.310400344024, 45973.77013114913, 45993.08013839705, 40695.796521017204, 40977.59022409797, 41055.0, 41213.58786412098, 41442.1711565773, 37550.624493754716, 37646.62353376431, 38027.80986095052, 38253.80873095673, 38424.80787596044, 7149.60677162761, 7155.320244576965, 7960.920390796018, 8076.353891688768, 8093.55485448306, 27499.587506187025, 30130.0, 30151.849240753654, 30174.245643859078, 30216.84891575528, 37990.24019519649, 38032.23935521219, 38339.6166038336, 38411.039724007125, 38457.42313865238, 9931.304808663324, 9963.950180249052, 10016.899831001596, 10185.439800811026, 10216.0, 10713.625023124154, 10877.238593298709, 10936.289141206114, 10995.780084398428, 11075.224734268524, 10544.630937917136, 10599.735006624587, 10632.468376580986, 10813.134949203888, 10813.783724325627, 10054.34646747959, 10215.131713804112, 10235.539400726837, 10235.897641023792, 10625.043746062891, 9864.309498335047, 10129.746756331151, 10199.0820826126, 10281.84577231357, 10505.054545090978, 8233.423660343718, 8236.629351679308, 8433.578321084044, 8468.322534197372, 8720.258778003687, 8854.867176992479, 9005.099490050943, 9014.278857691237, 9038.186563209343, 9075.455472671661], "unit": "score", "name": "yui.html", "value": 5493.439166188889}], "name": "dromaeo_css", "value": 6049.1536662198305}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 114.0, 114.0, 114.0, 102.0, 114.0, 115.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 160.0, 162.0, 129.0, 158.0, 154.0, 129.0, 175.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 162.0, 163.0, 163.0, 163.0, 163.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 83.0, 90.0, 74.0, 72.0, 72.0, 105.0, 92.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 139.0, 97.0, 97.0, 97.0, 139.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 149.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 72.0, 72.0, 71.0, 71.0, 72.0, 81.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 88.0, 86.0, 86.0, 86.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [135.0, 121.0, 123.0, 119.0, 128.0, 125.0, 121.0, 121.0, 122.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [141.0, 146.0, 150.0, 150.0, 149.0, 137.0, 150.0, 148.0, 148.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 71.0, 72.0, 72.0, 70.0, 71.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1531.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9449081803005], "unit": "score", "name": "Richards", "value": 211.45897999999997}, {"lowerIsBetter": false, "replicates": [187.65246762994934], "unit": "score", "name": "DeltaBlue", "value": 352.34282199999996}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [2022.2222222222222], "unit": "score", "name": "RayTrace", "value": 365.9286263736265}, {"lowerIsBetter": false, "replicates": [810.3727714748784], "unit": "score", "name": "Earley", "value": 822.4153420000002}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [44000.0], "unit": "score", "name": "RegExp", "value": 20.70420454545456}, {"lowerIsBetter": false, "replicates": [620.4334365325077], "unit": "score", "name": "Splay", "value": 131.3452744510978}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18701.11645750318}]} 13:32:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "18701.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1531.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6049.15"}}} 13:32:16 INFO - Return code: 0 13:32:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:32:16 INFO - # TBPL SUCCESS # 13:32:16 INFO - Running post-action listener: _resource_record_post_action 13:32:16 INFO - Running post-run listener: _resource_record_post_run 13:32:17 INFO - Total resource usage - Wall time: 1241s; CPU: 13.0%; Read bytes: 10420224; Write bytes: 522731520; Read time: 3172; Write time: 499420 13:32:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 79355904; Read time: 228; Write time: 124720 13:32:17 INFO - run-tests - Wall time: 1226s; CPU: 13.0%; Read bytes: 10416128; Write bytes: 443375616; Read time: 2944; Write time: 374700 13:32:17 INFO - Running post-run listener: _upload_blobber_files 13:32:17 INFO - Blob upload gear active. 13:32:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:32:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:32:17 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:32:17 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:32:18 INFO - (blobuploader) - INFO - Open directory for files ... 13:32:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:32:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:19 INFO - (blobuploader) - INFO - Done attempting. 13:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:19 INFO - (blobuploader) - INFO - Done attempting. 13:32:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:32:19 INFO - Return code: 0 13:32:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:32:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:32:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1359237ce2e1ef03814f9d6a0f6f430b0c604903aa92925f03d8040e43237752e88cb3e179d8cc090eb67bf3261b044f763ef40249bf533e7570917e22c61279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b771ae0cdc9ae97f03df12eebf729584f2b4ba658e9ae4ee9ceb447e272d0d6bb6291e07c83c2529c48a5b1a03c6e645001f1f4bf9fec3974a199c4aea858b4"} 13:32:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:32:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:32:19 INFO - Contents: 13:32:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1359237ce2e1ef03814f9d6a0f6f430b0c604903aa92925f03d8040e43237752e88cb3e179d8cc090eb67bf3261b044f763ef40249bf533e7570917e22c61279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b771ae0cdc9ae97f03df12eebf729584f2b4ba658e9ae4ee9ceb447e272d0d6bb6291e07c83c2529c48a5b1a03c6e645001f1f4bf9fec3974a199c4aea858b4"} 13:32:19 INFO - Copying logs to upload dir... 13:32:19 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1287.788454 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-01-09 13:32:19.289698) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 13:32:19.292911) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1359237ce2e1ef03814f9d6a0f6f430b0c604903aa92925f03d8040e43237752e88cb3e179d8cc090eb67bf3261b044f763ef40249bf533e7570917e22c61279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b771ae0cdc9ae97f03df12eebf729584f2b4ba658e9ae4ee9ceb447e272d0d6bb6291e07c83c2529c48a5b1a03c6e645001f1f4bf9fec3974a199c4aea858b4"} build_url:https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/XHA-TQs_TYC5DewFi4b7fQ/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/Firefox-Non-PGO/sha512/1359237ce2e1ef03814f9d6a0f6f430b0c604903aa92925f03d8040e43237752e88cb3e179d8cc090eb67bf3261b044f763ef40249bf533e7570917e22c61279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b771ae0cdc9ae97f03df12eebf729584f2b4ba658e9ae4ee9ceb447e272d0d6bb6291e07c83c2529c48a5b1a03c6e645001f1f4bf9fec3974a199c4aea858b4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 13:32:19.316985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:32:19.317412) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452349512.566044-1663130776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:32:19.400032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 13:32:19.400328) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 13:32:19.400598) ========= ========= Total master_lag: 0.22 =========