builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1452870723.16 results: success (0) buildid: 20160115062941 builduid: a9212b44ab1941e2828af60e84170628 revision: 3424598d23bd0d036282693a3e7af9bec70b127c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.157026) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.157460) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.157805) ========= 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=4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006493 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.204860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.205176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.289558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.289862) ========= 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=4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.346739) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.347097) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.347524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.347857) ========= 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=4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 07:12:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2016-01-15 07:12:03 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.272600 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.637184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.637533) ========= 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=4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019662 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.691223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:03.691853) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3424598d23bd0d036282693a3e7af9bec70b127c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3424598d23bd0d036282693a3e7af9bec70b127c --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=4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 07:12:03,783 truncating revision to first 12 chars 2016-01-15 07:12:03,783 Setting DEBUG logging. 2016-01-15 07:12:03,783 attempt 1/10 2016-01-15 07:12:03,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3424598d23bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 07:12:04,356 unpacking tar archive at: fx-team-3424598d23bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.845311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:04.550523) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:04.550883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:04.639420) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:04.640091) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:04.641048) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-15 07:12:04.641727) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:12:04 INFO - MultiFileLogger online at 20160115 07:12:04 in /builds/slave/test 07:12:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:12:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:12:04 INFO - {'append_to_log': False, 07:12:04 INFO - 'base_work_dir': '/builds/slave/test', 07:12:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:12:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:12:04 INFO - 'branch': 'Fx-Team-Non-PGO', 07:12:04 INFO - 'buildbot_json_path': 'buildprops.json', 07:12:04 INFO - 'config_files': ('talos/linux_config.py',), 07:12:04 INFO - 'default_actions': ('clobber', 07:12:04 INFO - 'read-buildbot-config', 07:12:04 INFO - 'download-and-extract', 07:12:04 INFO - 'populate-webroot', 07:12:04 INFO - 'create-virtualenv', 07:12:04 INFO - 'install', 07:12:04 INFO - 'run-tests'), 07:12:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:12:04 INFO - 'download_minidump_stackwalk': True, 07:12:04 INFO - 'download_symbols': 'ondemand', 07:12:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:12:04 INFO - 'tooltool.py': '/tools/tooltool.py', 07:12:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:12:04 INFO - '/tools/misc-python/virtualenv.py')}, 07:12:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:12:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:12:04 INFO - 'installer_path': 'installer.exe', 07:12:04 INFO - 'log_level': 'info', 07:12:04 INFO - 'log_name': 'talos', 07:12:04 INFO - 'log_to_console': True, 07:12:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:12:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:12:04 INFO - 'opt_config_files': (), 07:12:04 INFO - 'pip_index': False, 07:12:04 INFO - 'sps_profile': False, 07:12:04 INFO - 'sps_profile_interval': 0, 07:12:04 INFO - 'suite': 'dromaeojs-e10s', 07:12:04 INFO - 'system_bits': '32', 07:12:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:12:04 INFO - 'title': 'talos-linux64-ix-024', 07:12:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:12:04 INFO - 'use_talos_json': True, 07:12:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:12:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:12:04 INFO - 'work_dir': 'build'} 07:12:04 INFO - ##### 07:12:04 INFO - ##### Running clobber step. 07:12:04 INFO - ##### 07:12:04 INFO - Running pre-action listener: _resource_record_pre_action 07:12:04 INFO - Running main action method: clobber 07:12:04 INFO - rmtree: /builds/slave/test/build 07:12:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:12:05 INFO - Running post-action listener: _resource_record_post_action 07:12:05 INFO - ##### 07:12:05 INFO - ##### Running read-buildbot-config step. 07:12:05 INFO - ##### 07:12:05 INFO - Running pre-action listener: _resource_record_pre_action 07:12:05 INFO - Running main action method: read_buildbot_config 07:12:05 INFO - Using buildbot properties: 07:12:05 INFO - { 07:12:05 INFO - "project": "", 07:12:05 INFO - "product": "firefox", 07:12:05 INFO - "script_repo_revision": "production", 07:12:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:12:05 INFO - "repository": "", 07:12:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:12:05 INFO - "buildid": "20160115062941", 07:12:05 INFO - "pgo_build": "False", 07:12:05 INFO - "basedir": "/builds/slave/test", 07:12:05 INFO - "buildnumber": 701, 07:12:05 INFO - "slavename": "talos-linux64-ix-024", 07:12:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:12:05 INFO - "platform": "ubuntu64_hw", 07:12:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:12:05 INFO - "branch": "fx-team", 07:12:05 INFO - "repo_path": "integration/fx-team", 07:12:05 INFO - "revision": "3424598d23bd0d036282693a3e7af9bec70b127c", 07:12:05 INFO - "stage_platform": "linux64", 07:12:05 INFO - "builduid": "a9212b44ab1941e2828af60e84170628", 07:12:05 INFO - "slavebuilddir": "test" 07:12:05 INFO - } 07:12:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:12:05 INFO - Running post-action listener: _resource_record_post_action 07:12:05 INFO - ##### 07:12:05 INFO - ##### Running download-and-extract step. 07:12:05 INFO - ##### 07:12:05 INFO - Running pre-action listener: _resource_record_pre_action 07:12:05 INFO - Running main action method: download_and_extract 07:12:05 INFO - mkdir: /builds/slave/test/build/tests 07:12: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')]} 07:12:05 INFO - https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:12:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/test_packages.json 07:12:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/test_packages.json 07:12:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:12:10 INFO - Downloaded 1448 bytes. 07:12:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:12:10 INFO - Using the following test package requirements: 07:12:10 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:10 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:12:10 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:12:10 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'jsshell-linux-x86_64.zip'], 07:12:10 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:12:10 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:10 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:12:10 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:12:10 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:12:10 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:10 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:12:10 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:10 INFO - https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:12:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:12:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/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 07:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/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 07:12:14 INFO - Downloaded 21172667 bytes. 07:12:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:12:15 INFO - Return code: 0 07:12:15 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 07:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:15 INFO - https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/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 07:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/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 07:12:20 INFO - Downloaded 21172667 bytes. 07:12:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:12:21 INFO - Return code: 0 07:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:21 INFO - https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/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 07:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/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 07:12:23 INFO - Downloaded 11132144 bytes. 07:12:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:12:23 INFO - Return code: 0 07:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:23 INFO - https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/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 07:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EPAaOCTyQUC3DxXI5n5yUA/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 07:12:26 INFO - Downloaded 54121201 bytes. 07:12:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:12:26 INFO - mkdir: /builds/slave/test/properties 07:12:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:12:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:12:26 INFO - Contents: 07:12:26 INFO - build_url:https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:12:26 INFO - Running post-action listener: _resource_record_post_action 07:12:26 INFO - Running post-action listener: set_extra_try_arguments 07:12:26 INFO - ##### 07:12:26 INFO - ##### Running populate-webroot step. 07:12:26 INFO - ##### 07:12:26 INFO - Running pre-action listener: _resource_record_pre_action 07:12:26 INFO - Running main action method: populate_webroot 07:12:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:12:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:12:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:12:26 INFO - '--tppagecycles', 07:12:26 INFO - '7'], 07:12:26 INFO - 'tests': ['tsvgm']}}, 07:12:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:12:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:12:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:12:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:12:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:12:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:12:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:26 INFO - 'talos_options': ['--e10s'], 07:12:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:26 INFO - 'tests': ['damp', 'tps']}, 07:12:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:26 INFO - 'talos_options': ['--e10s'], 07:12:26 INFO - 'tests': ['damp', 'tps']}, 07:12:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:12:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:12:26 INFO - 'other': {'tests': ['a11yr', 07:12:26 INFO - 'ts_paint', 07:12:26 INFO - 'tpaint', 07:12:26 INFO - 'sessionrestore', 07:12:26 INFO - 'sessionrestore_no_auto_restore']}, 07:12:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:12:26 INFO - 'tests': ['a11yr', 07:12:26 INFO - 'ts_paint', 07:12:26 INFO - 'tpaint', 07:12:26 INFO - 'sessionrestore', 07:12:26 INFO - 'sessionrestore_no_auto_restore']}, 07:12:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:12:26 INFO - 'tests': ['a11yr', 07:12:26 INFO - 'ts_paint', 07:12:26 INFO - 'tpaint', 07:12:26 INFO - 'sessionrestore', 07:12:26 INFO - 'sessionrestore_no_auto_restore']}, 07:12:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:12:26 INFO - 'tests': ['a11yr', 07:12:26 INFO - 'ts_paint', 07:12:26 INFO - 'tpaint', 07:12:26 INFO - 'sessionrestore', 07:12:26 INFO - 'sessionrestore_no_auto_restore']}, 07:12:26 INFO - 'other_l64': {'tests': ['a11yr', 07:12:26 INFO - 'ts_paint', 07:12:26 INFO - 'tpaint', 07:12:26 INFO - 'sessionrestore', 07:12:26 INFO - 'sessionrestore_no_auto_restore']}, 07:12:26 INFO - 'other_nol64': {'tests': ['a11yr', 07:12:26 INFO - 'ts_paint', 07:12:26 INFO - 'tpaint', 07:12:26 INFO - 'sessionrestore', 07:12:26 INFO - 'sessionrestore_no_auto_restore']}, 07:12:26 INFO - 'svgr': {'tests': ['tsvgx', 07:12:26 INFO - 'tsvgr_opacity', 07:12:26 INFO - 'tart', 07:12:26 INFO - 'tscrollx', 07:12:26 INFO - 'cart']}, 07:12:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:12:26 INFO - 'tests': ['tsvgx', 07:12:26 INFO - 'tsvgr_opacity', 07:12:26 INFO - 'tart', 07:12:26 INFO - 'tscrollx', 07:12:26 INFO - 'cart']}, 07:12:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:26 INFO - 'tests': ['tp5o']}, 07:12:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:26 INFO - 'talos_options': ['--e10s'], 07:12:26 INFO - 'tests': ['tp5o']}, 07:12:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:26 INFO - 'talos_options': ['--xperf_path', 07:12:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:26 INFO - 'tests': ['tp5n']}, 07:12:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:26 INFO - 'talos_options': ['--e10s', 07:12:26 INFO - '--xperf_path', 07:12:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:26 INFO - 'tests': ['tp5n']}}, 07:12:26 INFO - 'talos.zip': {'path': '', 07:12:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:12:26 INFO - Running post-action listener: _resource_record_post_action 07:12:26 INFO - ##### 07:12:26 INFO - ##### Running create-virtualenv step. 07:12:26 INFO - ##### 07:12:26 INFO - Running pre-action listener: _resource_record_pre_action 07:12:26 INFO - Running main action method: create_virtualenv 07:12:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:12:26 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 07:12:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:12:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:12:26 INFO - Using real prefix '/usr' 07:12:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:12:27 INFO - Installing distribute.............................................................................................................................................................................................done. 07:12:29 INFO - Installing pip.................done. 07:12:29 INFO - Return code: 0 07:12:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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')]} 07:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe13a73af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', '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 07:12: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', 'pip>=1.5'] in /builds/slave/test/build 07:12: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 pip>=1.5 07:12:29 INFO - Using env: {'DISPLAY': ':0', 07:12:29 INFO - 'HOME': '/home/cltbld', 07:12:29 INFO - 'LANG': 'en_US.UTF-8', 07:12:29 INFO - 'LANGUAGE': 'en_US:en', 07:12:29 INFO - 'LOGNAME': 'cltbld', 07:12:29 INFO - 'MAIL': '/var/mail/cltbld', 07:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:29 INFO - 'MOZ_NO_REMOTE': '1', 07:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:29 INFO - 'NO_EM_RESTART': '1', 07:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:29 INFO - 'PWD': '/builds/slave/test', 07:12:29 INFO - 'SHELL': '/bin/bash', 07:12:29 INFO - 'SHLVL': '1', 07:12:29 INFO - 'TERM': 'linux', 07:12:29 INFO - 'TMOUT': '86400', 07:12:29 INFO - 'USER': 'cltbld', 07:12:29 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:29 INFO - '_': '/tools/buildbot/bin/python'} 07:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:29 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 07:12:29 INFO - Cleaning up... 07:12:29 INFO - Return code: 0 07:12:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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')]} 07:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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', '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 0x7fe13a73af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', '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 07:12: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', 'psutil>=0.7.1'] in /builds/slave/test/build 07:12: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 psutil>=0.7.1 07:12:29 INFO - Using env: {'DISPLAY': ':0', 07:12:29 INFO - 'HOME': '/home/cltbld', 07:12:29 INFO - 'LANG': 'en_US.UTF-8', 07:12:29 INFO - 'LANGUAGE': 'en_US:en', 07:12:29 INFO - 'LOGNAME': 'cltbld', 07:12:29 INFO - 'MAIL': '/var/mail/cltbld', 07:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:29 INFO - 'MOZ_NO_REMOTE': '1', 07:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:29 INFO - 'NO_EM_RESTART': '1', 07:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:29 INFO - 'PWD': '/builds/slave/test', 07:12:29 INFO - 'SHELL': '/bin/bash', 07:12:29 INFO - 'SHLVL': '1', 07:12:29 INFO - 'TERM': 'linux', 07:12:29 INFO - 'TMOUT': '86400', 07:12:29 INFO - 'USER': 'cltbld', 07:12:29 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:29 INFO - '_': '/tools/buildbot/bin/python'} 07:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:29 INFO - Downloading/unpacking psutil>=0.7.1 07:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:31 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:12:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:31 INFO - Installing collected packages: psutil 07:12:31 INFO - Running setup.py install for psutil 07:12:31 INFO - building 'psutil._psutil_linux' extension 07:12:31 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 07:12:31 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 07:12:31 INFO - building 'psutil._psutil_posix' extension 07:12:31 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 07:12:31 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 07:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:31 INFO - Successfully installed psutil 07:12:31 INFO - Cleaning up... 07:12:32 INFO - Return code: 0 07:12:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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')]} 07:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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', '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 0x7fe13a73af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', '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 07:12: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:12: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 mozsystemmonitor==0.0.0 07:12:32 INFO - Using env: {'DISPLAY': ':0', 07:12:32 INFO - 'HOME': '/home/cltbld', 07:12:32 INFO - 'LANG': 'en_US.UTF-8', 07:12:32 INFO - 'LANGUAGE': 'en_US:en', 07:12:32 INFO - 'LOGNAME': 'cltbld', 07:12:32 INFO - 'MAIL': '/var/mail/cltbld', 07:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:32 INFO - 'MOZ_NO_REMOTE': '1', 07:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:32 INFO - 'NO_EM_RESTART': '1', 07:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:32 INFO - 'PWD': '/builds/slave/test', 07:12:32 INFO - 'SHELL': '/bin/bash', 07:12:32 INFO - 'SHLVL': '1', 07:12:32 INFO - 'TERM': 'linux', 07:12:32 INFO - 'TMOUT': '86400', 07:12:32 INFO - 'USER': 'cltbld', 07:12:32 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:32 INFO - '_': '/tools/buildbot/bin/python'} 07:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:12:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:12:34 INFO - Installing collected packages: mozsystemmonitor 07:12:34 INFO - Running setup.py install for mozsystemmonitor 07:12:34 INFO - Successfully installed mozsystemmonitor 07:12:34 INFO - Cleaning up... 07:12:34 INFO - Return code: 0 07:12:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fe13a73af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', '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 07:12:34 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 07:12:34 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 07:12:34 INFO - Using env: {'DISPLAY': ':0', 07:12:34 INFO - 'HOME': '/home/cltbld', 07:12:34 INFO - 'LANG': 'en_US.UTF-8', 07:12:34 INFO - 'LANGUAGE': 'en_US:en', 07:12:34 INFO - 'LOGNAME': 'cltbld', 07:12:34 INFO - 'MAIL': '/var/mail/cltbld', 07:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:34 INFO - 'MOZ_NO_REMOTE': '1', 07:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:34 INFO - 'NO_EM_RESTART': '1', 07:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:34 INFO - 'PWD': '/builds/slave/test', 07:12:34 INFO - 'SHELL': '/bin/bash', 07:12:34 INFO - 'SHLVL': '1', 07:12:34 INFO - 'TERM': 'linux', 07:12:34 INFO - 'TMOUT': '86400', 07:12:34 INFO - 'USER': 'cltbld', 07:12:34 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:34 INFO - '_': '/tools/buildbot/bin/python'} 07:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:36 INFO - Downloading docopt-0.6.1.tar.gz 07:12:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:36 INFO - Running setup.py install for blobuploader 07:12:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:36 INFO - Running setup.py install for requests 07:12:37 INFO - Running setup.py install for docopt 07:12:37 INFO - Successfully installed blobuploader requests docopt 07:12:37 INFO - Cleaning up... 07:12:37 INFO - Return code: 0 07:12:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:37 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 0x7fe13a73af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', '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 07:12:37 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 07:12:37 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 07:12:37 INFO - Using env: {'DISPLAY': ':0', 07:12:37 INFO - 'HOME': '/home/cltbld', 07:12:37 INFO - 'LANG': 'en_US.UTF-8', 07:12:37 INFO - 'LANGUAGE': 'en_US:en', 07:12:37 INFO - 'LOGNAME': 'cltbld', 07:12:37 INFO - 'MAIL': '/var/mail/cltbld', 07:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:37 INFO - 'MOZ_NO_REMOTE': '1', 07:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:37 INFO - 'NO_EM_RESTART': '1', 07:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:37 INFO - 'PWD': '/builds/slave/test', 07:12:37 INFO - 'SHELL': '/bin/bash', 07:12:37 INFO - 'SHLVL': '1', 07:12:37 INFO - 'TERM': 'linux', 07:12:37 INFO - 'TMOUT': '86400', 07:12:37 INFO - 'USER': 'cltbld', 07:12:37 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:37 INFO - '_': '/tools/buildbot/bin/python'} 07:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:37 INFO - Running setup.py (path:/tmp/pip-CNfx9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:37 INFO - Running setup.py (path:/tmp/pip-p23N1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:37 INFO - Running setup.py (path:/tmp/pip-zF4WGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:37 INFO - Running setup.py (path:/tmp/pip-6X_Evh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:37 INFO - Running setup.py (path:/tmp/pip-49sq64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:37 INFO - Running setup.py (path:/tmp/pip-QtUvhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:38 INFO - Running setup.py (path:/tmp/pip-8cMcwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:38 INFO - Running setup.py (path:/tmp/pip-U82ukL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:38 INFO - Running setup.py (path:/tmp/pip-J5Uf4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:38 INFO - Running setup.py (path:/tmp/pip-BnUkVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:38 INFO - Running setup.py (path:/tmp/pip-zyD016-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:38 INFO - Running setup.py (path:/tmp/pip-7K31pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:38 INFO - Running setup.py (path:/tmp/pip-9pjZAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:38 INFO - Running setup.py (path:/tmp/pip-M_kZae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:38 INFO - Running setup.py (path:/tmp/pip-OWJJYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:38 INFO - Running setup.py (path:/tmp/pip-qVmd1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:38 INFO - Running setup.py (path:/tmp/pip-zOgQ0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:38 INFO - Running setup.py install for manifestparser 07:12:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozcrash 07:12:38 INFO - Running setup.py install for mozdebug 07:12:39 INFO - Running setup.py install for mozdevice 07:12:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozfile 07:12:39 INFO - Running setup.py install for mozhttpd 07:12:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozinfo 07:12:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozInstall 07:12:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozleak 07:12:39 INFO - Running setup.py install for mozlog 07:12:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for moznetwork 07:12:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozprocess 07:12:40 INFO - Running setup.py install for mozprofile 07:12:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Running setup.py install for mozrunner 07:12:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Running setup.py install for mozscreenshot 07:12:40 INFO - Running setup.py install for moztest 07:12:40 INFO - Running setup.py install for mozversion 07:12:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:40 INFO - Cleaning up... 07:12:40 INFO - Return code: 0 07:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe13a73af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', '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 07:12:40 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 07:12:40 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 07:12:40 INFO - Using env: {'DISPLAY': ':0', 07:12:40 INFO - 'HOME': '/home/cltbld', 07:12:40 INFO - 'LANG': 'en_US.UTF-8', 07:12:40 INFO - 'LANGUAGE': 'en_US:en', 07:12:40 INFO - 'LOGNAME': 'cltbld', 07:12:40 INFO - 'MAIL': '/var/mail/cltbld', 07:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:40 INFO - 'MOZ_NO_REMOTE': '1', 07:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:40 INFO - 'NO_EM_RESTART': '1', 07:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:40 INFO - 'PWD': '/builds/slave/test', 07:12:40 INFO - 'SHELL': '/bin/bash', 07:12:40 INFO - 'SHLVL': '1', 07:12:40 INFO - 'TERM': 'linux', 07:12:40 INFO - 'TMOUT': '86400', 07:12:40 INFO - 'USER': 'cltbld', 07:12:40 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:40 INFO - '_': '/tools/buildbot/bin/python'} 07:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:40 INFO - Running setup.py (path:/tmp/pip-dyG8hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:40 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)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:40 INFO - Running setup.py (path:/tmp/pip-H58_zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:40 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)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:40 INFO - Running setup.py (path:/tmp/pip-XXzc8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:40 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)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:41 INFO - Running setup.py (path:/tmp/pip-zXJrC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:41 INFO - Running setup.py (path:/tmp/pip-E6bCME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:41 INFO - Running setup.py (path:/tmp/pip-Onxp5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:41 INFO - Running setup.py (path:/tmp/pip-PM8Dje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:41 INFO - Running setup.py (path:/tmp/pip-8m0aFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:41 INFO - Running setup.py (path:/tmp/pip-kgT9bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:41 INFO - Running setup.py (path:/tmp/pip-xvDeAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:41 INFO - Running setup.py (path:/tmp/pip-YQVSWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:41 INFO - Running setup.py (path:/tmp/pip-lmgwEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:41 INFO - Running setup.py (path:/tmp/pip-l14ND4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:41 INFO - Running setup.py (path:/tmp/pip-rvdcYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:41 INFO - Running setup.py (path:/tmp/pip-T7cyoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:41 INFO - Running setup.py (path:/tmp/pip-GA134x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:41 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)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:41 INFO - Running setup.py (path:/tmp/pip-rXwty_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:42 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)) 07:12:42 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)) 07:12:42 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)) 07:12:42 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)) 07:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:43 INFO - Downloading blessings-1.5.1.tar.gz 07:12:43 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 07:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:43 INFO - Installing collected packages: blessings 07:12:43 INFO - Running setup.py install for blessings 07:12:43 INFO - Successfully installed blessings 07:12:43 INFO - Cleaning up... 07:12:43 INFO - Return code: 0 07:12:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:44 INFO - Reading from file tmpfile_stdout 07:12:44 INFO - Current package versions: 07:12:44 INFO - argparse == 1.2.1 07:12:44 INFO - blessings == 1.5.1 07:12:44 INFO - blobuploader == 1.2.4 07:12:44 INFO - docopt == 0.6.1 07:12:44 INFO - manifestparser == 1.1 07:12:44 INFO - mozInstall == 1.12 07:12:44 INFO - mozcrash == 0.16 07:12:44 INFO - mozdebug == 0.1 07:12:44 INFO - mozdevice == 0.48 07:12:44 INFO - mozfile == 1.2 07:12:44 INFO - mozhttpd == 0.7 07:12:44 INFO - mozinfo == 0.9 07:12:44 INFO - mozleak == 0.1 07:12:44 INFO - mozlog == 3.1 07:12:44 INFO - moznetwork == 0.27 07:12:44 INFO - mozprocess == 0.22 07:12:44 INFO - mozprofile == 0.28 07:12:44 INFO - mozrunner == 6.11 07:12:44 INFO - mozscreenshot == 0.1 07:12:44 INFO - mozsystemmonitor == 0.0 07:12:44 INFO - moztest == 0.7 07:12:44 INFO - mozversion == 1.4 07:12:44 INFO - psutil == 3.1.1 07:12:44 INFO - requests == 1.2.3 07:12:44 INFO - wsgiref == 0.1.2 07:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:44 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')]} 07:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:44 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')]} 07:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:44 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 0x7fe13a73af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', '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 07:12:44 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 07:12:44 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 07:12:44 INFO - Using env: {'DISPLAY': ':0', 07:12:44 INFO - 'HOME': '/home/cltbld', 07:12:44 INFO - 'LANG': 'en_US.UTF-8', 07:12:44 INFO - 'LANGUAGE': 'en_US:en', 07:12:44 INFO - 'LOGNAME': 'cltbld', 07:12:44 INFO - 'MAIL': '/var/mail/cltbld', 07:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:44 INFO - 'MOZ_NO_REMOTE': '1', 07:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:44 INFO - 'NO_EM_RESTART': '1', 07:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:44 INFO - 'PWD': '/builds/slave/test', 07:12:44 INFO - 'SHELL': '/bin/bash', 07:12:44 INFO - 'SHLVL': '1', 07:12:44 INFO - 'TERM': 'linux', 07:12:44 INFO - 'TMOUT': '86400', 07:12:44 INFO - 'USER': 'cltbld', 07:12:44 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:44 INFO - '_': '/tools/buildbot/bin/python'} 07:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:44 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)) 07:12:44 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)) 07:12:44 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)) 07:12:44 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)) 07:12:44 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)) 07:12:44 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)) 07:12:44 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)) 07:12:44 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)) 07:12:44 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)) 07:12:44 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)) 07:12:44 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)) 07:12:44 INFO - Cleaning up... 07:12:44 INFO - Return code: 0 07:12:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:12:44 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')]} 07:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:44 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')]} 07:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:44 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 0x7fe13a73af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', '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 07:12:44 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 07:12:44 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 07:12:44 INFO - Using env: {'DISPLAY': ':0', 07:12:44 INFO - 'HOME': '/home/cltbld', 07:12:44 INFO - 'LANG': 'en_US.UTF-8', 07:12:44 INFO - 'LANGUAGE': 'en_US:en', 07:12:44 INFO - 'LOGNAME': 'cltbld', 07:12:44 INFO - 'MAIL': '/var/mail/cltbld', 07:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:44 INFO - 'MOZ_NO_REMOTE': '1', 07:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:44 INFO - 'NO_EM_RESTART': '1', 07:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:44 INFO - 'PWD': '/builds/slave/test', 07:12:44 INFO - 'SHELL': '/bin/bash', 07:12:44 INFO - 'SHLVL': '1', 07:12:44 INFO - 'TERM': 'linux', 07:12:44 INFO - 'TMOUT': '86400', 07:12:44 INFO - 'USER': 'cltbld', 07:12:44 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:44 INFO - '_': '/tools/buildbot/bin/python'} 07:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:44 INFO - Downloading/unpacking jsonschema 07:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:12:46 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 07:12:46 INFO - Downloading/unpacking functools32 (from jsonschema) 07:12:46 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 07:12:46 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 07:12:46 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 07:12:46 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 07:12:46 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 07:12:46 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 07:12:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:12:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:12:46 INFO - warning: no files found matching '*.txt' 07:12:46 INFO - no previously-included directories found matching 'build' 07:12:46 INFO - no previously-included directories found matching 'dist' 07:12:46 INFO - no previously-included directories found matching '.git*' 07:12:46 INFO - Installing collected packages: jsonschema, functools32 07:12:46 INFO - Running setup.py install for functools32 07:12:46 INFO - warning: no files found matching '*.txt' 07:12:46 INFO - no previously-included directories found matching 'build' 07:12:46 INFO - no previously-included directories found matching 'dist' 07:12:46 INFO - no previously-included directories found matching '.git*' 07:12:46 INFO - Successfully installed jsonschema functools32 07:12:46 INFO - Cleaning up... 07:12:46 INFO - Return code: 0 07:12:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:46 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 0x7fe13a73af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', '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 07:12:46 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 07:12:46 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 07:12:46 INFO - Using env: {'DISPLAY': ':0', 07:12:46 INFO - 'HOME': '/home/cltbld', 07:12:46 INFO - 'LANG': 'en_US.UTF-8', 07:12:46 INFO - 'LANGUAGE': 'en_US:en', 07:12:46 INFO - 'LOGNAME': 'cltbld', 07:12:46 INFO - 'MAIL': '/var/mail/cltbld', 07:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:46 INFO - 'MOZ_NO_REMOTE': '1', 07:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:46 INFO - 'NO_EM_RESTART': '1', 07:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:46 INFO - 'PWD': '/builds/slave/test', 07:12:46 INFO - 'SHELL': '/bin/bash', 07:12:46 INFO - 'SHLVL': '1', 07:12:46 INFO - 'TERM': 'linux', 07:12:46 INFO - 'TMOUT': '86400', 07:12:46 INFO - 'USER': 'cltbld', 07:12:46 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:46 INFO - '_': '/tools/buildbot/bin/python'} 07:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:47 INFO - Downloading/unpacking flake8 07:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:12:48 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 07:12:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:12:48 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 07:12:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 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 07:12:49 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 07:12:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:12:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:49 INFO - no previously-included directories found matching 'docs/_build' 07:12:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:12:49 INFO - Running setup.py install for pep8 07:12:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:49 INFO - no previously-included directories found matching 'docs/_build' 07:12:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:12:49 INFO - Cleaning up... 07:12:49 INFO - Return code: 0 07:12:49 INFO - Running post-action listener: _resource_record_post_action 07:12:49 INFO - Running post-action listener: _start_resource_monitoring 07:12:49 INFO - Starting resource monitoring. 07:12:49 INFO - ##### 07:12:49 INFO - ##### Running install step. 07:12:49 INFO - ##### 07:12:49 INFO - Running pre-action listener: _resource_record_pre_action 07:12:49 INFO - Running main action method: install 07:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:49 INFO - Reading from file tmpfile_stdout 07:12:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:49 INFO - Reading from file tmpfile_stdout 07:12:49 INFO - Output received: 07:12:49 INFO - Usage: mozinstall [options] installer 07:12:49 INFO - Options: 07:12:49 INFO - -h, --help show this help message and exit 07:12:49 INFO - -d DEST, --destination=DEST 07:12:49 INFO - Directory to install application into. [default: 07:12:49 INFO - "/builds/slave/test"] 07:12:49 INFO - --app=APP Application being installed. [default: firefox] 07:12:49 INFO - mkdir: /builds/slave/test/build/application 07:12:49 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'] 07:12:49 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 07:13:05 INFO - Reading from file tmpfile_stdout 07:13:05 INFO - Output received: 07:13:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:13:05 INFO - Running post-action listener: _resource_record_post_action 07:13:05 INFO - ##### 07:13:05 INFO - ##### Running run-tests step. 07:13:05 INFO - ##### 07:13:05 INFO - Running pre-action listener: _resource_record_pre_action 07:13:05 INFO - Running main action method: run_tests 07:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:05 INFO - Python 2.7.3 07:13:05 INFO - Return code: 0 07:13:05 INFO - grabbing minidump binary from tooltool 07:13: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')]} 07:13:05 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 0x2b5f3d0>, '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 0x2acaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:05 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 07:13:05 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 07:13:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:05 INFO - Return code: 0 07:13:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:13:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:13:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:13:06 INFO - Return code: 0 07:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:13:06 INFO - Using env: {'DISPLAY': ':0', 07:13:06 INFO - 'HOME': '/home/cltbld', 07:13:06 INFO - 'LANG': 'en_US.UTF-8', 07:13:06 INFO - 'LANGUAGE': 'en_US:en', 07:13:06 INFO - 'LOGNAME': 'cltbld', 07:13:06 INFO - 'MAIL': '/var/mail/cltbld', 07:13:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:06 INFO - 'MOZ_NO_REMOTE': '1', 07:13:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:06 INFO - 'NO_EM_RESTART': '1', 07:13:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:06 INFO - 'PWD': '/builds/slave/test', 07:13:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:06 INFO - 'SHELL': '/bin/bash', 07:13:06 INFO - 'SHLVL': '1', 07:13:06 INFO - 'TERM': 'linux', 07:13:06 INFO - 'TMOUT': '86400', 07:13:06 INFO - 'USER': 'cltbld', 07:13:06 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564', 07:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:06 INFO - '_': '/tools/buildbot/bin/python'} 07:13:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:13:06 INFO - mozversion application_buildid: 20160115062941 07:13:06 INFO - mozversion application_changeset: 3424598d23bd0d036282693a3e7af9bec70b127c 07:13:06 INFO - mozversion application_display_name: Nightly 07:13:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:06 INFO - mozversion application_name: Firefox 07:13:06 INFO - mozversion application_remotingname: firefox 07:13:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:13:06 INFO - mozversion application_vendor: Mozilla 07:13:06 INFO - mozversion application_version: 46.0a1 07:13:06 INFO - mozversion platform_buildid: 20160115062941 07:13:06 INFO - mozversion platform_changeset: 3424598d23bd0d036282693a3e7af9bec70b127c 07:13:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:13:06 INFO - mozversion platform_version: 46.0a1 07:13:06 INFO - using testdate: 1452870786 07:13:06 INFO - actual date: 1452870786 07:13:06 INFO - starting webserver on 'localhost:47131' 07:13:06 INFO - SUITE-START | Running 3 tests 07:13:06 INFO - TEST-START | dromaeo_css 07:13:06 INFO - operating with platform_type : linux_ 07:13:06 INFO - Initialising browser for dromaeo_css test... 07:13:06 INFO - TEST-INFO | started process 6281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFO7vRS/profile http://localhost:47131/getInfo.html) 07:13:10 INFO - PROCESS | 6281 | 07:13:10 INFO - PROCESS | 6281 | (process:6362): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:13:11 INFO - PROCESS | 6281 | __metrics Screen width/height:1600/1200 07:13:11 INFO - PROCESS | 6281 | colorDepth:24 07:13:11 INFO - PROCESS | 6281 | Browser inner width/height: 1024/697 07:13:11 INFO - PROCESS | 6281 | __metrics 07:13:11 INFO - PROCESS | 6281 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:13:12 INFO - TEST-INFO | 6281: exit 0 07:13:12 INFO - Browser initialized. 07:13:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:13:12 INFO - TEST-INFO | started process 6411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFO7vRS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:13 INFO - PROCESS | 6411 | 07:13:13 INFO - PROCESS | 6411 | (process:6469): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:13:24 INFO - PROCESS | 6411 | RSS: Main: 150548480 07:13:24 INFO - PROCESS | 6411 | 07:14:13 INFO - PROCESS | 6411 | 1452870853953 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] 07:16:25 INFO - PROCESS | 6411 | Cycle 1(1): loaded http://localhost:47131/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47131/tests/dromaeo/cssquery-ext.html) 07:16:26 INFO - PROCESS | 6411 | RSS: Main: 156061696 07:16:26 INFO - PROCESS | 6411 | 07:19:28 INFO - PROCESS | 6411 | Cycle 1(1): loaded http://localhost:47131/tests/dromaeo/cssquery-ext.html (next: http://localhost:47131/tests/dromaeo/cssquery-jquery.html) 07:19:29 INFO - PROCESS | 6411 | RSS: Main: 151535616 07:19:29 INFO - PROCESS | 6411 | 07:22:31 INFO - PROCESS | 6411 | Cycle 1(1): loaded http://localhost:47131/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47131/tests/dromaeo/cssquery-mootools.html) 07:22:31 INFO - PROCESS | 6411 | RSS: Main: 151158784 07:22:31 INFO - PROCESS | 6411 | 07:25:33 INFO - PROCESS | 6411 | Cycle 1(1): loaded http://localhost:47131/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47131/tests/dromaeo/cssquery-prototype.html) 07:25:34 INFO - PROCESS | 6411 | RSS: Main: 149921792 07:25:34 INFO - PROCESS | 6411 | 07:28:36 INFO - PROCESS | 6411 | Cycle 1(1): loaded http://localhost:47131/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47131/tests/dromaeo/cssquery-yui.html) 07:28:37 INFO - PROCESS | 6411 | RSS: Main: 150896640 07:28:37 INFO - PROCESS | 6411 | 07:31:39 INFO - PROCESS | 6411 | Cycle 1(1): loaded http://localhost:47131/tests/dromaeo/cssquery-yui.html (next: http://localhost:47131/tests/dromaeo/cssquery-dojo.html) 07:31:40 INFO - PROCESS | 6411 | RSS: Main: 153710592 07:31:40 INFO - PROCESS | 6411 | 07:31:40 INFO - PROCESS | 6411 | __start_tp_report 07:31:40 INFO - PROCESS | 6411 | _x_x_mozilla_page_load 07:31:40 INFO - PROCESS | 6411 | _x_x_mozilla_page_load_details 07:31:40 INFO - PROCESS | 6411 | |i|pagename|runs| 07:31:40 INFO - PROCESS | 6411 | |0;dojo.html;2618.423946731719;2632.2366513711027;2663.547196976514;2675.3177939625393;2684.7315268473153;4405.6255218306405;4545.045540436508;4568.040711450591;4576.061907309002;4594;4525.2080885844925;4538.319252112176;4591.5867571918525;4605.055963527478;4611.631069514439;4169.332906734923;4199.580041995791;4259.16946195492;4260.169266992938;4276.23027854986;4268.530461649216;4270.487541495009;4322.675799315049;4340.153670034345;4371.715838470505;4159.542450330461;4221.5567365426805;4258.276093064186;4268.295731204347;4316.3741257517795;4221.894452638678;4234.280172370673;4238.830446782125;4240.9151816963795;4274.508431530383;4212.620864122213;4234.06850492891;4242.363645453176;4249.277622804131;4259.531451540328;4368.344748287751;4468.173387923244;4475.015496590745;4483.439570053743;4487.214737420938;4921.384826896638;4922.803087876517;4942.802287908479;4944.579710724557;4990.750462476862;4870.707757534524;4882.707037577721;4883.609311255091;4886.486918873538;4933.555979961785;4435.933460998088;4479.686421950498;4512.909741805145;4547;4583.358329833826;4905.9264111038365;4922.08941345845;5048.343715317059;5081.695098294114;5161.019406312788;4784.952150478451;4785.210440277316;4797.664163508591;4801.68789028712;4837.250226214942;4762.690425122356;4845;4863.781129849165;4874.731889746098;4925.064237794808;4738.976305118453;4762.59517940972;4813.350197723333;4838.685485443435;4869.245266983623;4823.445303790038;4847.830325938575;4850.53919877611;4859.07677541266;4889.975550122226;4004.3593025115842;4070.3487442009136;4079.6124368184974;4082.632563069338;4087.509498860156;3550.857965681344;3583.104223944014;3600.8199590020395;3616.0779001354485;3625.7099432045375;4249.3413520904305;4292.3561465780385;4303.289957157097;4314.115606300701;4337.95888986641;4788.952110478851;4875.68308059975;4884.633652476078;4950.2822090796635;4988.401391833003;4209.158168366278;4240.681948853849;4249.46881639795;4280.935785963213;4315.395844581761;4298.312270036841;4328.480582330078;4353.325234588644;4379.1460665170625;4410.514843367227;4556.157110934488;4637.65217608674;4642.2340313847835;4673.532646735367;4731.101090792738;4890.951090489049;4893.045856058035;4899.730514821719;4899.877503062452;4917.9016419672125;4590.517995610547;4639.721616703008;4642.257238841904;4646.605038571759;4679.36828528158;4683.625309975262;4778.331033655221;4789.521047895322;4863.635227358033;4880.975595122001;4857.514248575114;4858.95141048585;4884.755762211804;4891.755412229445;4926.039422312758;4540.387047748512;4697.107549565571;4702.811887524461;4709.4584122824945;4758.500357462417;4648.186567350767;4769.070031343855;4801.567858892717;4825.9758701206265;4835.032993401263;4610.700304480332;4614.377059096979;4626.953730462652;4652.046330502171;4684.7891844867745;4615.284630882219;4729.9054018920115;4764.332993380999;4777.641676874317;4806.855794326176;4642.117997580449;4674.7896344663895;4694.178518759135;4696.953030469652;4745.359376484131 07:31:40 INFO - PROCESS | 6411 | |1;ext.html;482.7730966445769;495.5663794180092;497.45777102957794;519.7089629807306;520.877593765465;31446.371072578564;31867.52198717018;32002.519962200586;32049.51925721116;32276.354472910527;34760.82619586905;35132.824335878286;35350;35398.2920341593;35458.46812297818;7474.887876681841;7724.806879828021;7727.922720772776;7729.845403091935;7730;7530.397568194531;7660.655270512841;7663.693452261903;7670.654820533062;7681.539107653531;7750.8449831003345;7837.059552853666;7903.881441778378;7904.762857114296;7916.168802275764;7787.221277872224;7829.060512738451;7843.529388236696;7848.13670496245;7855.725049623293;7584.1278253001055;7686.807829804244;7717.884231736529;7734.845303093963;7737.922620773833;34207.657923420695;34679.6532034679;34685.826570866986;34786.47820282698;34787.478187827204;2672.812903096784;2703.91888243353;2851.3584443500254;2882.5964364988918;2899.3331533747146;24483.387915302083;27440.17679469619;27618.447631047467;27940.720592794016;28270.293242668893;3300.6534313897178;3313.801171929692;3354.76516643835;3391.5251864738957;3415.8975230743117;212081;212547;213430;213485;213816;45878.54121458809;46730.53269467262;51024.23463648048;51547.48452515427;52089;45955.310670339306;46004;46572;46821.765891170326;46884;11773.46944897175;11773.705657358634;11908.46411911466;11908.46411911466;11983.940080299717;8913.28693704502;8931;8978.68574599899;9009.099090090938;9022.188003079755;17016.744748828776;17318.307267709402;17944;18012.54968625795;18281.268749250146;7103.6093014883645;7403.703851845866;7445.143808462096;7461.477696561297;7576.356009739124;768.7732119024901;773.6905237904883;812.9390295727844;814.6212011414602;820.8932838730926;21472.355829325144;23238.373313867865;23800.404989875045;26358.20925372242;26907;905.9139381758722;906.3429013964954;928.8838895138108;951.833429149896;995.2386424385351;12441.813372799415;13240.668983275302;13518.459261629425;13552;13651.863481365257;363591;375480;377297;378436;378528;41806.1638767223;41827.58172418237;42350;42442;42472.57527424748;1149.971250718722;1152.095604950127;1163.1508998431023;1165.4383126610214;1277.0613599004723;24119.502672112798;24897.25308240756;24921.626175607016;24957.75211239467;26610.201693949213;37102.628973711;38008.239835202585;38051.42922856104;38149.23701525899;38306.80846595749;204478;205017;205331;205710;205855;25583.104591339215;37099.44350834793;37433.25133497261;37453.25093498169;37684.246315074095;30142.397152057274;30551;30862.382752345275;30888.53667194949;31110.377792444477;28160.155195344174;28232.85883570569;28703.425931480837;28846.134615961553;28965.42069158563;26302.473950521264;26872.462550749267;26985.57129858322;27219.59170612482;27527.31181720473;29220.123396298146;29225.269368265963;29341.119766407042;29478;29504;28328.433431330846;29703.108906732832;31015.53476697806;31287.217819554695;31308.843455782575;23525.88237058804;24793.752062479143;25458.236252912444;25745.742542575084;26245.606315905658 07:31:40 INFO - PROCESS | 6411 | |2;jquery.html;321.33644025088194;336.8938784282951;337.03103577215506;337.93072420153874;341.6839423533231;11839.585614503494;12336.198147120453;14015.509457169;14529.78205326921;14627.78058329126;9336.626534938612;9717.416954982687;9719.125278724914;13172.275524846129;14945;4490.9550904491025;4637.6289896808175;4699.412573428322;4699.765011749416;4701.694389864648;4789.760511974405;4904.779284932169;5001.349824522825;5008.874778130539;5014.022265658198;4810.470848206694;4984.32711583937;4996.600271978251;5009.198528235483;5019.52314530119;5191.714455704935;5202.739863006872;5221.556167725748;5229.241759944786;5237.973810130944;4630.073985202939;4828.613710903154;4835.806567737286;4850.490698476645;4858.514148585148;10840;14312.856871431257;17177.65644687112;17655.205515751695;17738.645227095385;1734.6964281250857;1752.7633769441218;1765.0760670868815;1766.2316892151955;1848.9537761555935;8447.155284471564;8687.34844886636;8775.385722999392;8820.426672266347;8857.911420885774;1707.0611163859828;1744.4069016534313;1771.3711632370453;1802.9368972086045;1851.0929644474245;43147.78426107881;44434.99999999968;48012;48807.51192488065;50186.74906625444;8871.66924961261;9135;9149.634014639472;9236.815263694689;9265.72202833916;11680.766384672259;11746.29522228669;11764.70588235301;11783.410829458493;11865.644030679094;5891.23413956183;6135.570510064253;6135.662538560422;6258.468030217483;6437.066625339299;5930.792422265286;5936.5250779937505;5962.701864906738;6017.18767966319;6030.969845150747;3884.495015648004;3995.260876737813;4018.477597912311;4079.8164082616354;4104.076582768913;1586.6747316800029;1637.321745211168;1645.489898131583;1669.5074952888926;1678.093829332147;713.7180813578607;719.8956151358024;757.2427572427572;773.6402572803561;783.9725609603637;13647.249401283025;13706.24615646149;13916.51292204768;13979.231142287272;14027.78958315626;759.2635143910509;765.2347652347653;765.2997507280776;778.1440415542858;828.88810010649;7820.84358312842;7901.288884000468;7924.088729796147;7972.242636949481;8417.663293468193;425773;434079;435836;440886;441155;61354.38645613576;64095;64504.35495645077;65190.348096519374;65223.67388163029;1038.672818062308;1047.7799662070897;1050.3855244681795;1064.1380481809758;1078.0190027075323;12446.751064978831;13055.543055992996;13325.200487970753;13500.189988600716;13952.58142255734;26896.59655105136;27499.17502474929;28079.578806317513;28182.15453536397;28553.28616784597;37064.44403334006;37158.44262336121;37338;37562.746235225975;39035.41446878356;5971.58198926071;6056.424639659225;6243.43809057187;6293.748250070129;6415.486761059011;7530.623468826647;8497.702580409903;8898.377113602244;9047.050059743633;9272.397294175857;7869.527828330319;8113.229243221885;8153.510789352657;8179.713710020121;8186.590670466572;7478.813029674302;7500.811830240183;7636.31273185416;7756.8448631028195;7756.8448631028195;7806.102298235775;7876.133625301098;7987.840243194987;8154.510729356258;8173.836523269382;6298.874022519615;6310.652914089769;6311.084892690626;6333.524985626004;6450.193725784277;7368;7539.359154471931;8401.537915414467;8654.134586541295;8773.692920747742 07:31:40 INFO - PROCESS | 6411 | |3;mootools.html;1170.2802776292576;1175.1891195075398;1200.657812523431;1635.4766474728092;1658;6223.564350495467;6363.1727875376255;7157.677904494297;7344.192138864721;7394.519356241841;6674.065630811678;6798.388145066943;6891.414229790461;6906.896396554043;6913.516053876231;1941.7766956799971;1975.7036444533292;1977.831884289837;1979.3171355882268;1979.703044543323;1947.289239427613;1956.628240634282;1967.8819270843724;2030.4213299209728;2037.4295197344768;2047.7133201351824;2047.9180832766672;2055.157385471957;2060.9896950515226;2074.7199128117663;2063.1850419084453;2064.6799746039387;2067.390119914629;2070.285751415759;2071.5028393185603;1973.6644770389069;1998.530345368837;2013.7784843667184;2015.5968806238811;2019.9596008079902;6862.279460656609;6910.896336554905;6937.167539895195;6941.826454338631;6968.825779355506;3979.462772525701;4066.9593304066875;4076.0217547788616;4082.632563069338;4089.7750623715683;2600.9349766255805;2606.2962999989895;2630.092618046771;2656.1633085577982;2662.6671666041743;832.8375966686499;849.6728759427665;867.1415298854089;871.1114663043724;890.1810334492283;9835.803283934281;9856.260780441495;9885.406875587416;9891.010898910123;9901.207903367786;3721.2371463849845;3734.6825519830577;3759.191773768653;3773.8679146230297;3811.8284677189595;8378.162183781573;8407.201315874981;8423.284020858173;8425.536595487185;8454.112318206622;4134.111166099243;4134.793260337031;4142.2751018572235;4149.419081328617;4159.688023398257;3208.9839550802562;3304.074859039473;3713.5729391119826;3763.717721170923;3807.9619203807606;3215.758818088653;3273.083536609753;3299.851506682157;3303.4714445688574;3309.5035744638017;1019.1235537437798;1023.2888142740724;1029;1029.8712660917386;1036.3212096076932;983.5180761426849;1006.3559322033905;1008.6469735592631;1046.1160319529986;1110.5002748763088;6508.251551071593;6639.037339585733;6647.567908085959;6665.500087493458;6687.197536295578;956.9712908612753;970.6942313171328;979.3438396274513;983.6114734679761;993.6174572789528;4884.511548845087;4937.530934561211;4994.076095922266;5020.422651395063;5022.045811295842;8331.83336333282;8555.828883422297;8609.053004169537;8687.131286871263;8690.217880390795;8471.534065626449;8547.529885856213;8575.914240857637;8584.098669639723;8617.310615150773;6554.246261679968;6682.632455214913;6714.29499902513;6768.526203165731;6784.966075169691;6390.201224846895;6411.262704789009;6412.487001039999;6418.582792118497;6428.646424446701;7573.129090154703;7657.9617101916365;7667.808304792425;7695.153533111466;7800.765977020698;7749.108852482037;7867.527948323119;7900.6049697513745;7917.643706033127;7933.8413231736195;5402.51377376038;5517.393086760533;6024.3975602439405;6158.414950579688;6256.186695729526;6523.217213934358;6736.056952026622;6771.458283337222;6772.661366931732;6795.694193761392;5839.772670621598;6020.8795824084145;6036.7283472244735;6075.848103797441;6093.939060609515;6352.745890164527;6411.935880641134;6461;6470.38531339522;6510.869782604226;6341.112244285711;6346.4605508532295;6407.1350367701625;6408.455281301141;6409.807705768834;5850.882982340415;5867.911981320198;5870.090136028923;5877.970610146922;5890.410958904075;6042.274927008787;6054.424829641177;6057.273127224761;6063.636181828928;6086.178365920544 07:31:40 INFO - PROCESS | 6411 | |4;prototype.html;281.19578006900264;282.9292676830792;285.995710064349;290.5293424652064;296.6514345643868;5448.91826622601;5635.380108188096;5704.942950570498;5726.112452569853;5810.477057064863;5622.128570071635;5669.886602267952;5672.290963629546;5675.5459563234945;5688.118341657039;4270.1886641538085;4270.444842170514;4272.9359059614135;4286.935695964563;4301.204277208711;4269.551697071794;4278.229918614648;4285.271503844354;4287.742735435884;4292.871213863574;3960.3861401482673;4132.297509423405;4171.958280417188;4247.872563823074;4253.936190957138;4149.439825623533;4155.293600087962;4164.8125834337525;4168.603982621661;4179.080602267496;3555.1112221944513;3556.733245006609;3557.1640664443835;3571;3572.624874388204;5358.892822143535;5369.382521010095;5390.434004429557;5393.7572809223675;5400.891982160374;4601.493835678073;4748.477667456577;4767.332573439721;4777.474477807438;4792.712437253741;5673.489385955242;5845.620034697774;5917.763289468416;5920.111983202511;5943.019401798698;3840.884773456773;3842.1163132479405;3845.5193100862393;3854.9421758673643;3870.9032274193087;6149.385061493859;6178;6219.844503887393;6219.968900155515;6241.9999999999545;3824;3938.0548668319398;3938.8030598469963;3966.801659916993;3968.583298753589;3987.322155233617;3989.2420440116284;3998.8400463981698;4018.015586181346;4020.43713880057;4701.294805779092;4748.3114948332295;4748.382710247714;4750.477447480775;4751.976240118846;5835.445632664975;5853.326867410217;5872.559558033165;5875.823725288248;5888.4700376966275;1388.1532265318149;1392.262101086426;1422.1040744331005;1423.5088894331438;1423.5800438870558;902.9683961061331;921.953902304882;926.7312479380904;934.3179478980383;935.8502639577634;5078.187490001582;5099.286099946011;5101.744912754348;5102.311187989574;5108.106081435734;6027.36712645166;6051.757929682852;6069.180660610761;6075.422834830684;6079.8480037998515;5072.771725272371;5077.213031980049;5081.034603425337;5085.618578606619;5085.64400491962;3199.808011519316;3263.902082937516;3281.2945216778508;3299;3322.850471728778;5813.302403711497;5815.505682017076;5819.621724587888;5824.912626310609;5834.299884013945;6348.746050158034;6379.106925030499;6386.904196437057;6397.488200943913;6398.488120950313;5736.713164341766;5813.331466881363;5826.650400975955;5882.823515294548;5885.117232415172;6151.507879369729;6174.598651087665;6178.938210617836;6180.103884936749;6217.533684973555;6018.51851851842;6037.637741735334;6042.063480160582;6046;6051.667158306159;5636.774529018793;5790.189373487631;5810.244668193108;5810.448007439287;5842.240508734008;3950.743201691881;3999.220152070435;4023.2556976959354;4024.6981476389974;4030.8387664493093;6177.444030037139;6180.134781130735;6185.783497577563;6186.659733714509;6189;5877.882442351214;5919.4080591940465;5920.970395147997;5926;5926.525877929842;5717.885642287048;5884.852878678067;5950.285965684146;5953.732082056231;5954.672493012926;5722.141678748221;5817.185594016756;5818.418158184148;5819.098039803837;5843.590948633725;5975;5978.402159784161;5981.551383646157;5982.4316689914385;5992.760289588367;5674.546036317167;5789.652620842763;5794.884102318014;5797.594168408171;5801.245838041028 07:31:40 INFO - PROCESS | 6411 | |5;yui.html;679.969401376938;680.520233235569;705.0763499815242;709.7090193020862;713.8393861381193;10845.295055821367;10958.28771129876;10988;10992.395418251994;11027.17296202784;10620;12021.699457513545;12315.568955086574;12350.567730129447;12371.628851134481;555.6305057137009;565.9037963546207;575.5108158065652;613.4632196827775;728.1953441447204;732.4543215304606;742.5396254322301;747.8952946587482;752.0524139584136;753.5215138387109;743.323575546253;752.0148605327012;767.4282659418712;768.8769796832507;772.474717192309;765.2921048030578;767.1791183433728;767.2365995834125;767.8425922685836;769.1116760142045;569.1803802524352;569.8518385219832;570.1220121013635;570.4267211452506;572.3075079154229;11284.943575282154;11287.604933827359;11291.604793832259;11298.717532061683;11340.206185567014;10573.418461984587;10870.945645271802;10916.345019298788;10918.836217456745;11018.614348497764;9115.58979845902;9260;9299.628014879398;9419.576119074658;9422.858657120149;3170.8731650733944;3189.1382983994986;3200.679932006804;3227.822469764162;3255.5930508686415;41128.38307425391;41147.38278925818;41290.9999999997;41326.173476530304;41375.1724965499;8453.49279043247;8459.661613535513;8644.178803013703;8811.955940220258;8954.552272386354;14471.204083775283;14574.417023318949;14592.343344549521;14609;14615.488457903923;5945.791897283574;6001.849953751103;6059.0608455689435;6114.694265286718;6128.724207410677;3500.807455589967;3511;3524.5946716127974;3533.964660353415;3577.159367548624;2527;2531.886065127074;2556;2556.872156392173;2557.3350928758286;446.7900086959124;453.35397059190524;453.95914367706405;458.68350837921724;459.24912767624505;463.9582437580634;489.9951000490021;501.7691861743566;552.2875490617139;570.823044856096;7030.402415794715;7041.5775053496955;7069.823254418578;7152.713891444388;7177.066981292399;426.32853256121734;452.8279253883503;458.04024210698327;511.1208720999874;577.6765011593521;3321.9169520762175;3473.4442489201606;3564.0198945289735;3581.0331210573;3687.778733276012;41562.1687566247;44842.55157448449;44859.10281794411;44879.55120448819;44892.3266151008;39828.402573961415;39847;40002.59997399989;40475;40652.18695626071;37653.43519847204;37678.623213768056;38209.426858597144;38758.22483550313;39364.803175983936;7530.698772049057;7536.107393275768;7597.164311925573;7624.5425274483705;7732.110807257012;28244.576331354634;28800.85599571989;29119.126426207247;29206.56190157107;29643;34867.293667556645;34926.30147397089;39276.803615981735;39364.60635393724;39573;8729.258013068706;9027.4132181408;9144.277370448614;9267.119623635745;9291.6283348668;10412.375257484575;10503.579856805642;10539.525721342405;10600.664531147399;10806.35161890289;10109.545070471993;10182.439965801952;10297.588096476056;10496.68509944703;10770.676879693621;9869.407835529892;9896.703098907044;9923.603055877684;10002.199824013916;10012.39925604466;9697.127258546765;9814.116729494379;9853.655122070693;10254.384736915808;10444.529996150039;8100.2304781045705;8141.633626486704;8333.250007499355;8482.279006284534;8599.097094805205;8103.797405064921;8284.50292982423;8289.917100829156;8367.707130250412;8415.513486846945 07:31:40 INFO - PROCESS | 6411 | __end_tp_report 07:31:40 INFO - PROCESS | 6411 | __start_cc_report 07:31:40 INFO - PROCESS | 6411 | _x_x_mozilla_cycle_collect,330 07:31:40 INFO - PROCESS | 6411 | __end_cc_report 07:31:40 INFO - PROCESS | 6411 | __startTimestamp1452871900013__endTimestamp 07:31:40 INFO - PROCESS | 6411 | 07:31:40 INFO - PROCESS | 6411 | ------- Summary: start ------- 07:31:40 INFO - PROCESS | 6411 | Number of tests: 6 07:31:40 INFO - PROCESS | 6411 | 07:31:40 INFO - PROCESS | 6411 | [#0] dojo.html Cycles:165 Average:4516.66 Median:4637.65 stddev:454.82 (9.8%) stddev-sans-first:431.15 07:31:40 INFO - PROCESS | 6411 | Values: 2618.4 2632.2 2663.5 2675.3 2684.7 4405.6 4545.0 4568.0 4576.1 4594.0 4525.2 4538.3 4591.6 4605.1 4611.6 4169.3 4199.6 4259.2 4260.2 4276.2 4268.5 4270.5 4322.7 4340.2 4371.7 4159.5 4221.6 4258.3 4268.3 4316.4 4221.9 4234.3 4238.8 4240.9 4274.5 4212.6 4234.1 4242.4 4249.3 4259.5 4368.3 4468.2 4475.0 4483.4 4487.2 4921.4 4922.8 4942.8 4944.6 4990.8 4870.7 4882.7 4883.6 4886.5 4933.6 4435.9 4479.7 4512.9 4547.0 4583.4 4905.9 4922.1 5048.3 5081.7 5161.0 4785.0 4785.2 4797.7 4801.7 4837.3 4762.7 4845.0 4863.8 4874.7 4925.1 4739.0 4762.6 4813.4 4838.7 4869.2 4823.4 4847.8 4850.5 4859.1 4890.0 4004.4 4070.3 4079.6 4082.6 4087.5 3550.9 3583.1 3600.8 3616.1 3625.7 4249.3 4292.4 4303.3 4314.1 4338.0 4789.0 4875.7 4884.6 4950.3 4988.4 4209.2 4240.7 4249.5 4280.9 4315.4 4298.3 4328.5 4353.3 4379.1 4410.5 4556.2 4637.7 4642.2 4673.5 4731.1 4891.0 4893.0 4899.7 4899.9 4917.9 4590.5 4639.7 4642.3 4646.6 4679.4 4683.6 4778.3 4789.5 4863.6 4881.0 4857.5 4859.0 4884.8 4891.8 4926.0 4540.4 4697.1 4702.8 4709.5 4758.5 4648.2 4769.1 4801.6 4826.0 4835.0 4610.7 4614.4 4627.0 4652.0 4684.8 4615.3 4729.9 4764.3 4777.6 4806.9 4642.1 4674.8 4694.2 4697.0 4745.4 07:31:40 INFO - PROCESS | 6411 | 07:31:40 INFO - PROCESS | 6411 | [#1] ext.html Cycles:180 Average:40585.71 Median:18811.78 stddev:72686.95 (386.4%) stddev-sans-first:72828.49 07:31:40 INFO - PROCESS | 6411 | Values: 482.8 495.6 497.5 519.7 520.9 31446.4 31867.5 32002.5 32049.5 32276.4 34760.8 35132.8 35350.0 35398.3 35458.5 7474.9 7724.8 7727.9 7729.8 7730.0 7530.4 7660.7 7663.7 7670.7 7681.5 7750.8 7837.1 7903.9 7904.8 7916.2 7787.2 7829.1 7843.5 7848.1 7855.7 7584.1 7686.8 7717.9 7734.8 7737.9 34207.7 34679.7 34685.8 34786.5 34787.5 2672.8 2703.9 2851.4 2882.6 2899.3 24483.4 27440.2 27618.4 27940.7 28270.3 3300.7 3313.8 3354.8 3391.5 3415.9 212081.0 212547.0 213430.0 213485.0 213816.0 45878.5 46730.5 51024.2 51547.5 52089.0 45955.3 46004.0 46572.0 46821.8 46884.0 11773.5 11773.7 11908.5 11908.5 11983.9 8913.3 8931.0 8978.7 9009.1 9022.2 17016.7 17318.3 17944.0 18012.5 18281.3 7103.6 7403.7 7445.1 7461.5 7576.4 768.8 773.7 812.9 814.6 820.9 21472.4 23238.4 23800.4 26358.2 26907.0 905.9 906.3 928.9 951.8 995.2 12441.8 13240.7 13518.5 13552.0 13651.9 363591.0 375480.0 377297.0 378436.0 378528.0 41806.2 41827.6 42350.0 42442.0 42472.6 1150.0 1152.1 1163.2 1165.4 1277.1 24119.5 24897.3 24921.6 24957.8 26610.2 37102.6 38008.2 38051.4 38149.2 38306.8 204478.0 205017.0 205331.0 205710.0 205855.0 25583.1 37099.4 37433.3 37453.3 37684.2 30142.4 30551.0 30862.4 30888.5 31110.4 28160.2 28232.9 28703.4 28846.1 28965.4 26302.5 26872.5 26985.6 27219.6 27527.3 29220.1 29225.3 29341.1 29478.0 29504.0 28328.4 29703.1 31015.5 31287.2 31308.8 23525.9 24793.8 25458.2 25745.7 26245.6 07:31:40 INFO - PROCESS | 6411 | 07:31:40 INFO - PROCESS | 6411 | [#2] jquery.html Cycles:180 Average:22751.30 Median:4998.98 stddev:71209.08 (1424.5%) stddev-sans-first:71388.92 07:31:40 INFO - PROCESS | 6411 | Values: 321.3 336.9 337.0 337.9 341.7 11839.6 12336.2 14015.5 14529.8 14627.8 9336.6 9717.4 9719.1 13172.3 14945.0 4491.0 4637.6 4699.4 4699.8 4701.7 4789.8 4904.8 5001.3 5008.9 5014.0 4810.5 4984.3 4996.6 5009.2 5019.5 5191.7 5202.7 5221.6 5229.2 5238.0 4630.1 4828.6 4835.8 4850.5 4858.5 10840.0 14312.9 17177.7 17655.2 17738.6 1734.7 1752.8 1765.1 1766.2 1849.0 8447.2 8687.3 8775.4 8820.4 8857.9 1707.1 1744.4 1771.4 1802.9 1851.1 43147.8 44435.0 48012.0 48807.5 50186.7 8871.7 9135.0 9149.6 9236.8 9265.7 11680.8 11746.3 11764.7 11783.4 11865.6 5891.2 6135.6 6135.7 6258.5 6437.1 5930.8 5936.5 5962.7 6017.2 6031.0 3884.5 3995.3 4018.5 4079.8 4104.1 1586.7 1637.3 1645.5 1669.5 1678.1 713.7 719.9 757.2 773.6 784.0 13647.2 13706.2 13916.5 13979.2 14027.8 759.3 765.2 765.3 778.1 828.9 7820.8 7901.3 7924.1 7972.2 8417.7 425773.0 434079.0 435836.0 440886.0 441155.0 61354.4 64095.0 64504.4 65190.3 65223.7 1038.7 1047.8 1050.4 1064.1 1078.0 12446.8 13055.5 13325.2 13500.2 13952.6 26896.6 27499.2 28079.6 28182.2 28553.3 37064.4 37158.4 37338.0 37562.7 39035.4 5971.6 6056.4 6243.4 6293.7 6415.5 7530.6 8497.7 8898.4 9047.1 9272.4 7869.5 8113.2 8153.5 8179.7 8186.6 7478.8 7500.8 7636.3 7756.8 7756.8 7806.1 7876.1 7987.8 8154.5 8173.8 6298.9 6310.7 6311.1 6333.5 6450.2 7368.0 7539.4 8401.5 8654.1 8773.7 07:31:40 INFO - PROCESS | 6411 | 07:31:40 INFO - PROCESS | 6411 | [#3] mootools.html Cycles:180 Average:4902.76 Median:6090.06 stddev:2598.34 (42.7%) stddev-sans-first:2590.48 07:31:40 INFO - PROCESS | 6411 | Values: 1170.3 1175.2 1200.7 1635.5 1658.0 6223.6 6363.2 7157.7 7344.2 7394.5 6674.1 6798.4 6891.4 6906.9 6913.5 1941.8 1975.7 1977.8 1979.3 1979.7 1947.3 1956.6 1967.9 2030.4 2037.4 2047.7 2047.9 2055.2 2061.0 2074.7 2063.2 2064.7 2067.4 2070.3 2071.5 1973.7 1998.5 2013.8 2015.6 2020.0 6862.3 6910.9 6937.2 6941.8 6968.8 3979.5 4067.0 4076.0 4082.6 4089.8 2600.9 2606.3 2630.1 2656.2 2662.7 832.8 849.7 867.1 871.1 890.2 9835.8 9856.3 9885.4 9891.0 9901.2 3721.2 3734.7 3759.2 3773.9 3811.8 8378.2 8407.2 8423.3 8425.5 8454.1 4134.1 4134.8 4142.3 4149.4 4159.7 3209.0 3304.1 3713.6 3763.7 3808.0 3215.8 3273.1 3299.9 3303.5 3309.5 1019.1 1023.3 1029.0 1029.9 1036.3 983.5 1006.4 1008.6 1046.1 1110.5 6508.3 6639.0 6647.6 6665.5 6687.2 957.0 970.7 979.3 983.6 993.6 4884.5 4937.5 4994.1 5020.4 5022.0 8331.8 8555.8 8609.1 8687.1 8690.2 8471.5 8547.5 8575.9 8584.1 8617.3 6554.2 6682.6 6714.3 6768.5 6785.0 6390.2 6411.3 6412.5 6418.6 6428.6 7573.1 7658.0 7667.8 7695.2 7800.8 7749.1 7867.5 7900.6 7917.6 7933.8 5402.5 5517.4 6024.4 6158.4 6256.2 6523.2 6736.1 6771.5 6772.7 6795.7 5839.8 6020.9 6036.7 6075.8 6093.9 6352.7 6411.9 6461.0 6470.4 6510.9 6341.1 6346.5 6407.1 6408.5 6409.8 5850.9 5867.9 5870.1 5878.0 5890.4 6042.3 6054.4 6057.3 6063.6 6086.2 07:31:40 INFO - PROCESS | 6411 | 07:31:40 INFO - PROCESS | 6411 | [#4] prototype.html Cycles:180 Average:4834.98 Median:5672.89 stddev:1490.97 (26.3%) stddev-sans-first:1455.45 07:31:40 INFO - PROCESS | 6411 | Values: 281.2 282.9 286.0 290.5 296.7 5448.9 5635.4 5704.9 5726.1 5810.5 5622.1 5669.9 5672.3 5675.5 5688.1 4270.2 4270.4 4272.9 4286.9 4301.2 4269.6 4278.2 4285.3 4287.7 4292.9 3960.4 4132.3 4172.0 4247.9 4253.9 4149.4 4155.3 4164.8 4168.6 4179.1 3555.1 3556.7 3557.2 3571.0 3572.6 5358.9 5369.4 5390.4 5393.8 5400.9 4601.5 4748.5 4767.3 4777.5 4792.7 5673.5 5845.6 5917.8 5920.1 5943.0 3840.9 3842.1 3845.5 3854.9 3870.9 6149.4 6178.0 6219.8 6220.0 6242.0 3824.0 3938.1 3938.8 3966.8 3968.6 3987.3 3989.2 3998.8 4018.0 4020.4 4701.3 4748.3 4748.4 4750.5 4752.0 5835.4 5853.3 5872.6 5875.8 5888.5 1388.2 1392.3 1422.1 1423.5 1423.6 903.0 922.0 926.7 934.3 935.9 5078.2 5099.3 5101.7 5102.3 5108.1 6027.4 6051.8 6069.2 6075.4 6079.8 5072.8 5077.2 5081.0 5085.6 5085.6 3199.8 3263.9 3281.3 3299.0 3322.9 5813.3 5815.5 5819.6 5824.9 5834.3 6348.7 6379.1 6386.9 6397.5 6398.5 5736.7 5813.3 5826.7 5882.8 5885.1 6151.5 6174.6 6178.9 6180.1 6217.5 6018.5 6037.6 6042.1 6046.0 6051.7 5636.8 5790.2 5810.2 5810.4 5842.2 3950.7 3999.2 4023.3 4024.7 4030.8 6177.4 6180.1 6185.8 6186.7 6189.0 5877.9 5919.4 5921.0 5926.0 5926.5 5717.9 5884.9 5950.3 5953.7 5954.7 5722.1 5817.2 5818.4 5819.1 5843.6 5975.0 5978.4 5981.6 5982.4 5992.8 5674.5 5789.7 5794.9 5797.6 5801.2 07:31:40 INFO - PROCESS | 6411 | 07:31:40 INFO - PROCESS | 6411 | [#5] yui.html Cycles:180 Average:11498.19 Median:22672.58 stddev:12895.99 (56.9%) stddev-sans-first:12906.58 07:31:40 INFO - PROCESS | 6411 | Values: 680.0 680.5 705.1 709.7 713.8 10845.3 10958.3 10988.0 10992.4 11027.2 10620.0 12021.7 12315.6 12350.6 12371.6 555.6 565.9 575.5 613.5 728.2 732.5 742.5 747.9 752.1 753.5 743.3 752.0 767.4 768.9 772.5 765.3 767.2 767.2 767.8 769.1 569.2 569.9 570.1 570.4 572.3 11284.9 11287.6 11291.6 11298.7 11340.2 10573.4 10870.9 10916.3 10918.8 11018.6 9115.6 9260.0 9299.6 9419.6 9422.9 3170.9 3189.1 3200.7 3227.8 3255.6 41128.4 41147.4 41291.0 41326.2 41375.2 8453.5 8459.7 8644.2 8812.0 8954.6 14471.2 14574.4 14592.3 14609.0 14615.5 5945.8 6001.8 6059.1 6114.7 6128.7 3500.8 3511.0 3524.6 3534.0 3577.2 2527.0 2531.9 2556.0 2556.9 2557.3 446.8 453.4 454.0 458.7 459.2 464.0 490.0 501.8 552.3 570.8 7030.4 7041.6 7069.8 7152.7 7177.1 426.3 452.8 458.0 511.1 577.7 3321.9 3473.4 3564.0 3581.0 3687.8 41562.2 44842.6 44859.1 44879.6 44892.3 39828.4 39847.0 40002.6 40475.0 40652.2 37653.4 37678.6 38209.4 38758.2 39364.8 7530.7 7536.1 7597.2 7624.5 7732.1 28244.6 28800.9 29119.1 29206.6 29643.0 34867.3 34926.3 39276.8 39364.6 39573.0 8729.3 9027.4 9144.3 9267.1 9291.6 10412.4 10503.6 10539.5 10600.7 10806.4 10109.5 10182.4 10297.6 10496.7 10770.7 9869.4 9896.7 9923.6 10002.2 10012.4 9697.1 9814.1 9853.7 10254.4 10444.5 8100.2 8141.6 8333.3 8482.3 8599.1 8103.8 8284.5 8289.9 8367.7 8415.5 07:31:40 INFO - PROCESS | 6411 | -------- Summary: end -------- 07:31:40 INFO - PROCESS | 6411 | 07:31:40 INFO - TEST-INFO | 6411: exit 0 07:31:40 INFO - TEST-OK | dromaeo_css | took 1113904ms 07:31:40 INFO - TEST-START | kraken 07:31:40 INFO - operating with platform_type : linux_ 07:31:40 INFO - Initialising browser for kraken test... 07:31:40 INFO - TEST-INFO | started process 6659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqimQJZ/profile http://localhost:47131/getInfo.html) 07:31:44 INFO - PROCESS | 6659 | 07:31:44 INFO - PROCESS | 6659 | (process:6734): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:31:45 INFO - PROCESS | 6659 | __metrics Screen width/height:1600/1200 07:31:45 INFO - PROCESS | 6659 | colorDepth:24 07:31:45 INFO - PROCESS | 6659 | Browser inner width/height: 1024/697 07:31:45 INFO - PROCESS | 6659 | __metrics 07:31:45 INFO - PROCESS | 6659 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:31:46 INFO - TEST-INFO | 6659: exit 0 07:31:46 INFO - Browser initialized. 07:31:46 INFO - Running cycle 1/1 for kraken test... 07:31:46 INFO - TEST-INFO | started process 6783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqimQJZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:47 INFO - PROCESS | 6783 | 07:31:47 INFO - PROCESS | 6783 | (process:6841): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:31:58 INFO - PROCESS | 6783 | RSS: Main: 150790144 07:31:58 INFO - PROCESS | 6783 | 07:32:00 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47131/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:01 INFO - PROCESS | 6783 | RSS: Main: 149966848 07:32:01 INFO - PROCESS | 6783 | 07:32:04 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47131/tests/kraken/driver.html?testName=audio-dft) 07:32:04 INFO - PROCESS | 6783 | RSS: Main: 153399296 07:32:04 INFO - PROCESS | 6783 | 07:32:07 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47131/tests/kraken/driver.html?testName=audio-fft) 07:32:08 INFO - PROCESS | 6783 | RSS: Main: 147128320 07:32:08 INFO - PROCESS | 6783 | 07:32:10 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47131/tests/kraken/driver.html?testName=audio-oscillator) 07:32:11 INFO - PROCESS | 6783 | RSS: Main: 147193856 07:32:11 INFO - PROCESS | 6783 | 07:32:13 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47131/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:14 INFO - PROCESS | 6783 | RSS: Main: 148021248 07:32:14 INFO - PROCESS | 6783 | 07:32:17 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47131/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:17 INFO - PROCESS | 6783 | RSS: Main: 148516864 07:32:17 INFO - PROCESS | 6783 | 07:32:21 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47131/tests/kraken/driver.html?testName=imaging-desaturate) 07:32:21 INFO - PROCESS | 6783 | RSS: Main: 148434944 07:32:21 INFO - PROCESS | 6783 | 07:32:24 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47131/tests/kraken/driver.html?testName=json-parse-financial) 07:32:25 INFO - PROCESS | 6783 | RSS: Main: 148467712 07:32:25 INFO - PROCESS | 6783 | 07:32:27 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47131/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:32:27 INFO - PROCESS | 6783 | RSS: Main: 149315584 07:32:27 INFO - PROCESS | 6783 | 07:32:29 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47131/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:30 INFO - PROCESS | 6783 | RSS: Main: 149409792 07:32:30 INFO - PROCESS | 6783 | 07:32:32 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47131/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:32 INFO - PROCESS | 6783 | RSS: Main: 149618688 07:32:32 INFO - PROCESS | 6783 | 07:32:35 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:36 INFO - PROCESS | 6783 | RSS: Main: 149987328 07:32:36 INFO - PROCESS | 6783 | 07:32:38 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:39 INFO - PROCESS | 6783 | RSS: Main: 149692416 07:32:39 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | Cycle 1(1): loaded http://localhost:47131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47131/tests/kraken/driver.html?testName=ai-astar) 07:32:41 INFO - PROCESS | 6783 | RSS: Main: 149864448 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | __start_tp_report 07:32:41 INFO - PROCESS | 6783 | _x_x_mozilla_page_load 07:32:41 INFO - PROCESS | 6783 | _x_x_mozilla_page_load_details 07:32:41 INFO - PROCESS | 6783 | |i|pagename|runs| 07:32:41 INFO - PROCESS | 6783 | |0;ai-astar;114;108;115;115;115;125;114;113;115;112 07:32:41 INFO - PROCESS | 6783 | |1;audio-beat-detection;154;139;156;171;139;159;158;143;170;133 07:32:41 INFO - PROCESS | 6783 | |2;audio-dft;165;163;163;164;164;164;167;160;162;162 07:32:41 INFO - PROCESS | 6783 | |3;audio-fft;72;74;73;73;76;73;157;75;73;72 07:32:41 INFO - PROCESS | 6783 | |4;audio-oscillator;97;98;136;98;99;98;142;97;97;139 07:32:41 INFO - PROCESS | 6783 | |5;imaging-gaussian-blur;109;110;109;110;110;110;110;109;110;109 07:32:41 INFO - PROCESS | 6783 | |6;imaging-darkroom;148;148;148;147;148;149;148;148;148;147 07:32:41 INFO - PROCESS | 6783 | |7;imaging-desaturate;96;98;96;96;96;96;95;96;95;96 07:32:41 INFO - PROCESS | 6783 | |8;json-parse-financial;69;72;68;70;74;70;70;70;68;70 07:32:41 INFO - PROCESS | 6783 | |9;json-stringify-tinderbox;67;70;83;68;72;68;67;68;68;67 07:32:41 INFO - PROCESS | 6783 | |10;stanford-crypto-aes;83;85;86;87;86;84;84;85;85;85 07:32:41 INFO - PROCESS | 6783 | |11;stanford-crypto-ccm;135;118;130;129;123;132;123;140;129;126 07:32:41 INFO - PROCESS | 6783 | |12;stanford-crypto-pbkdf2;144;166;151;151;144;149;160;153;152;144 07:32:41 INFO - PROCESS | 6783 | |13;stanford-crypto-sha256-iterative;73;72;71;81;71;71;70;70;70;74 07:32:41 INFO - PROCESS | 6783 | __end_tp_report 07:32:41 INFO - PROCESS | 6783 | __start_cc_report 07:32:41 INFO - PROCESS | 6783 | _x_x_mozilla_cycle_collect,795 07:32:41 INFO - PROCESS | 6783 | __end_cc_report 07:32:41 INFO - PROCESS | 6783 | __startTimestamp1452871961440__endTimestamp 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | ------- Summary: start ------- 07:32:41 INFO - PROCESS | 6783 | Number of tests: 14 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:4.25 (3.7%) stddev-sans-first:4.50 07:32:41 INFO - PROCESS | 6783 | Values: 114.0 108.0 115.0 115.0 115.0 125.0 114.0 113.0 115.0 112.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:157.00 stddev:13.21 (8.4%) stddev-sans-first:13.99 07:32:41 INFO - PROCESS | 6783 | Values: 154.0 139.0 156.0 171.0 139.0 159.0 158.0 143.0 170.0 133.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:1.90 (1.2%) stddev-sans-first:1.92 07:32:41 INFO - PROCESS | 6783 | Values: 165.0 163.0 163.0 164.0 164.0 164.0 167.0 160.0 162.0 162.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#3] audio-fft Cycles:10 Average:81.80 Median:73.00 stddev:26.45 (36.2%) stddev-sans-first:27.82 07:32:41 INFO - PROCESS | 6783 | Values: 72.0 74.0 73.0 73.0 76.0 73.0 157.0 75.0 73.0 72.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:97.50 stddev:20.00 (20.5%) stddev-sans-first:20.65 07:32:41 INFO - PROCESS | 6783 | Values: 97.0 98.0 136.0 98.0 99.0 98.0 142.0 97.0 97.0 139.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:32:41 INFO - PROCESS | 6783 | Values: 109.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:32:41 INFO - PROCESS | 6783 | Values: 148.0 148.0 148.0 147.0 148.0 149.0 148.0 148.0 148.0 147.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 07:32:41 INFO - PROCESS | 6783 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#8] json-parse-financial Cycles:10 Average:70.10 Median:70.00 stddev:1.79 (2.6%) stddev-sans-first:1.86 07:32:41 INFO - PROCESS | 6783 | Values: 69.0 72.0 68.0 70.0 74.0 70.0 70.0 70.0 68.0 70.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:68.00 stddev:4.89 (7.2%) stddev-sans-first:5.09 07:32:41 INFO - PROCESS | 6783 | Values: 67.0 70.0 83.0 68.0 72.0 68.0 67.0 68.0 68.0 67.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:1.15 (1.4%) stddev-sans-first:0.97 07:32:41 INFO - PROCESS | 6783 | Values: 83.0 85.0 86.0 87.0 86.0 84.0 84.0 85.0 85.0 85.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:129.50 stddev:6.38 (4.9%) stddev-sans-first:6.32 07:32:41 INFO - PROCESS | 6783 | Values: 135.0 118.0 130.0 129.0 123.0 132.0 123.0 140.0 129.0 126.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:151.50 stddev:7.15 (4.7%) stddev-sans-first:7.07 07:32:41 INFO - PROCESS | 6783 | Values: 144.0 166.0 151.0 151.0 144.0 149.0 160.0 153.0 152.0 144.0 07:32:41 INFO - PROCESS | 6783 | 07:32:41 INFO - PROCESS | 6783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:71.50 stddev:3.33 (4.7%) stddev-sans-first:3.53 07:32:41 INFO - PROCESS | 6783 | Values: 73.0 72.0 71.0 81.0 71.0 71.0 70.0 70.0 70.0 74.0 07:32:41 INFO - PROCESS | 6783 | -------- Summary: end -------- 07:32:41 INFO - PROCESS | 6783 | 07:32:42 INFO - TEST-INFO | 6783: exit 0 07:32:42 INFO - TEST-OK | kraken | took 61645ms 07:32:42 INFO - TEST-START | v8_7 07:32:42 INFO - operating with platform_type : linux_ 07:32:42 INFO - Initialising browser for v8_7 test... 07:32:42 INFO - TEST-INFO | started process 7069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5d72LA/profile http://localhost:47131/getInfo.html) 07:32:45 INFO - PROCESS | 7069 | 07:32:45 INFO - PROCESS | 7069 | (process:7140): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:32:46 INFO - PROCESS | 7069 | __metrics Screen width/height:1600/1200 07:32:46 INFO - PROCESS | 7069 | colorDepth:24 07:32:46 INFO - PROCESS | 7069 | Browser inner width/height: 1024/697 07:32:46 INFO - PROCESS | 7069 | __metrics 07:32:46 INFO - PROCESS | 7069 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:32:47 INFO - TEST-INFO | 7069: exit 0 07:32:47 INFO - Browser initialized. 07:32:47 INFO - Running cycle 1/1 for v8_7 test... 07:32:47 INFO - TEST-INFO | started process 7189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5d72LA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:49 INFO - PROCESS | 7189 | 07:32:49 INFO - PROCESS | 7189 | (process:7247): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:32:59 INFO - PROCESS | 7189 | RSS: Main: 150085632 07:32:59 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | Cycle 1(1): loaded http://localhost:47131/tests/v8_7/run.html (next: http://localhost:47131/tests/v8_7/run.html) 07:33:22 INFO - PROCESS | 7189 | RSS: Main: 145887232 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | __start_tp_report 07:33:22 INFO - PROCESS | 7189 | _x_x_mozilla_page_load 07:33:22 INFO - PROCESS | 7189 | _x_x_mozilla_page_load_details 07:33:22 INFO - PROCESS | 7189 | |i|pagename|runs| 07:33:22 INFO - PROCESS | 7189 | |0;Richards;167.42005692281936 07:33:22 INFO - PROCESS | 7189 | |1;DeltaBlue;187.30099269526127 07:33:22 INFO - PROCESS | 7189 | |2;Encrypt;279.4076557697681 07:33:22 INFO - PROCESS | 7189 | |3;Decrypt;5181.347150259067 07:33:22 INFO - PROCESS | 7189 | |4;RayTrace;1101.3215859030836 07:33:22 INFO - PROCESS | 7189 | |5;Earley;705.4263565891473 07:33:22 INFO - PROCESS | 7189 | |6;Boyer;12268.292682926829 07:33:22 INFO - PROCESS | 7189 | |7;RegExp;42638.29787234042 07:33:22 INFO - PROCESS | 7189 | |8;Splay;600.2400960384153 07:33:22 INFO - PROCESS | 7189 | |9;NavierStokes;4835.748792270531 07:33:22 INFO - PROCESS | 7189 | __end_tp_report 07:33:22 INFO - PROCESS | 7189 | __startTimestamp1452872002656__endTimestamp 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | ------- Summary: start ------- 07:33:22 INFO - PROCESS | 7189 | Number of tests: 10 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 167.4 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#1] DeltaBlue Cycles:1 Average:187.30 Median:187.30 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 187.3 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 279.4 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 5181.3 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 1101.3 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#5] Earley Cycles:1 Average:705.43 Median:705.43 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 705.4 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 12268.3 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#7] RegExp Cycles:1 Average:42638.30 Median:42638.30 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 42638.3 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#8] Splay Cycles:1 Average:600.24 Median:600.24 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 600.2 07:33:22 INFO - PROCESS | 7189 | 07:33:22 INFO - PROCESS | 7189 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:33:22 INFO - PROCESS | 7189 | Values: 4835.7 07:33:22 INFO - PROCESS | 7189 | -------- Summary: end -------- 07:33:22 INFO - PROCESS | 7189 | 07:33:23 INFO - TEST-INFO | 7189: exit 0 07:33:23 INFO - TEST-OK | v8_7 | took 41239ms 07:33:23 INFO - SUITE-END | took 1216s 07:33:24 INFO - Completed test suite (00:20:17) 07:33:24 INFO - Working with test: dromaeo_css 07:33:24 INFO - Generating results file: dromaeo_css 07:33:24 INFO - Working with test: kraken 07:33:24 INFO - Generating results file: kraken 07:33:24 INFO - javascript benchmark 07:33:24 INFO - Working with test: v8_7 07:33:24 INFO - Generating results file: v8_7 07:33:24 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:33:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 07:33:24 INFO - process_Request line: dromaeo_css 5991.17 graph.html#tests=[[72,132,43]] 07:33:24 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:33:24 INFO - process_Request line: kraken 1552.70 graph.html#tests=[[232,132,43]] 07:33:24 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:33:24 INFO - process_Request line: v8_7 20289.86 graph.html#tests=[[230,132,43]] 07:33:24 INFO - RETURN: dromaeo_css: 5991.17 07:33:24 INFO - RETURN: kraken: 1552.70 07:33:24 INFO - RETURN: v8_7: 20289.86 07:33:24 INFO - javascript benchmark 07:33:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2618.423946731719, 2632.2366513711027, 2663.547196976514, 2675.3177939625393, 2684.7315268473153, 4405.6255218306405, 4545.045540436508, 4568.040711450591, 4576.061907309002, 4594.0, 4525.2080885844925, 4538.319252112176, 4591.5867571918525, 4605.055963527478, 4611.631069514439, 4169.332906734923, 4199.580041995791, 4259.16946195492, 4260.169266992938, 4276.23027854986, 4268.530461649216, 4270.487541495009, 4322.675799315049, 4340.153670034345, 4371.715838470505, 4159.542450330461, 4221.5567365426805, 4258.276093064186, 4268.295731204347, 4316.3741257517795, 4221.894452638678, 4234.280172370673, 4238.830446782125, 4240.9151816963795, 4274.508431530383, 4212.620864122213, 4234.06850492891, 4242.363645453176, 4249.277622804131, 4259.531451540328, 4368.344748287751, 4468.173387923244, 4475.015496590745, 4483.439570053743, 4487.214737420938, 4921.384826896638, 4922.803087876517, 4942.802287908479, 4944.579710724557, 4990.750462476862, 4870.707757534524, 4882.707037577721, 4883.609311255091, 4886.486918873538, 4933.555979961785, 4435.933460998088, 4479.686421950498, 4512.909741805145, 4547.0, 4583.358329833826, 4905.9264111038365, 4922.08941345845, 5048.343715317059, 5081.695098294114, 5161.019406312788, 4784.952150478451, 4785.210440277316, 4797.664163508591, 4801.68789028712, 4837.250226214942, 4762.690425122356, 4845.0, 4863.781129849165, 4874.731889746098, 4925.064237794808, 4738.976305118453, 4762.59517940972, 4813.350197723333, 4838.685485443435, 4869.245266983623, 4823.445303790038, 4847.830325938575, 4850.53919877611, 4859.07677541266, 4889.975550122226, 4004.3593025115842, 4070.3487442009136, 4079.6124368184974, 4082.632563069338, 4087.509498860156, 3550.857965681344, 3583.104223944014, 3600.8199590020395, 3616.0779001354485, 3625.7099432045375, 4249.3413520904305, 4292.3561465780385, 4303.289957157097, 4314.115606300701, 4337.95888986641, 4788.952110478851, 4875.68308059975, 4884.633652476078, 4950.2822090796635, 4988.401391833003, 4209.158168366278, 4240.681948853849, 4249.46881639795, 4280.935785963213, 4315.395844581761, 4298.312270036841, 4328.480582330078, 4353.325234588644, 4379.1460665170625, 4410.514843367227, 4556.157110934488, 4637.65217608674, 4642.2340313847835, 4673.532646735367, 4731.101090792738, 4890.951090489049, 4893.045856058035, 4899.730514821719, 4899.877503062452, 4917.9016419672125, 4590.517995610547, 4639.721616703008, 4642.257238841904, 4646.605038571759, 4679.36828528158, 4683.625309975262, 4778.331033655221, 4789.521047895322, 4863.635227358033, 4880.975595122001, 4857.514248575114, 4858.95141048585, 4884.755762211804, 4891.755412229445, 4926.039422312758, 4540.387047748512, 4697.107549565571, 4702.811887524461, 4709.4584122824945, 4758.500357462417, 4648.186567350767, 4769.070031343855, 4801.567858892717, 4825.9758701206265, 4835.032993401263, 4610.700304480332, 4614.377059096979, 4626.953730462652, 4652.046330502171, 4684.7891844867745, 4615.284630882219, 4729.9054018920115, 4764.332993380999, 4777.641676874317, 4806.855794326176, 4642.117997580449, 4674.7896344663895, 4694.178518759135, 4696.953030469652, 4745.359376484131], "unit": "score", "name": "dojo.html", "value": 4489.251565233705}, {"lowerIsBetter": false, "replicates": [482.7730966445769, 495.5663794180092, 497.45777102957794, 519.7089629807306, 520.877593765465, 31446.371072578564, 31867.52198717018, 32002.519962200586, 32049.51925721116, 32276.354472910527, 34760.82619586905, 35132.824335878286, 35350.0, 35398.2920341593, 35458.46812297818, 7474.887876681841, 7724.806879828021, 7727.922720772776, 7729.845403091935, 7730.0, 7530.397568194531, 7660.655270512841, 7663.693452261903, 7670.654820533062, 7681.539107653531, 7750.8449831003345, 7837.059552853666, 7903.881441778378, 7904.762857114296, 7916.168802275764, 7787.221277872224, 7829.060512738451, 7843.529388236696, 7848.13670496245, 7855.725049623293, 7584.1278253001055, 7686.807829804244, 7717.884231736529, 7734.845303093963, 7737.922620773833, 34207.657923420695, 34679.6532034679, 34685.826570866986, 34786.47820282698, 34787.478187827204, 2672.812903096784, 2703.91888243353, 2851.3584443500254, 2882.5964364988918, 2899.3331533747146, 24483.387915302083, 27440.17679469619, 27618.447631047467, 27940.720592794016, 28270.293242668893, 3300.6534313897178, 3313.801171929692, 3354.76516643835, 3391.5251864738957, 3415.8975230743117, 212081.0, 212547.0, 213430.0, 213485.0, 213816.0, 45878.54121458809, 46730.53269467262, 51024.23463648048, 51547.48452515427, 52089.0, 45955.310670339306, 46004.0, 46572.0, 46821.765891170326, 46884.0, 11773.46944897175, 11773.705657358634, 11908.46411911466, 11908.46411911466, 11983.940080299717, 8913.28693704502, 8931.0, 8978.68574599899, 9009.099090090938, 9022.188003079755, 17016.744748828776, 17318.307267709402, 17944.0, 18012.54968625795, 18281.268749250146, 7103.6093014883645, 7403.703851845866, 7445.143808462096, 7461.477696561297, 7576.356009739124, 768.7732119024901, 773.6905237904883, 812.9390295727844, 814.6212011414602, 820.8932838730926, 21472.355829325144, 23238.373313867865, 23800.404989875045, 26358.20925372242, 26907.0, 905.9139381758722, 906.3429013964954, 928.8838895138108, 951.833429149896, 995.2386424385351, 12441.813372799415, 13240.668983275302, 13518.459261629425, 13552.0, 13651.863481365257, 363591.0, 375480.0, 377297.0, 378436.0, 378528.0, 41806.1638767223, 41827.58172418237, 42350.0, 42442.0, 42472.57527424748, 1149.971250718722, 1152.095604950127, 1163.1508998431023, 1165.4383126610214, 1277.0613599004723, 24119.502672112798, 24897.25308240756, 24921.626175607016, 24957.75211239467, 26610.201693949213, 37102.628973711, 38008.239835202585, 38051.42922856104, 38149.23701525899, 38306.80846595749, 204478.0, 205017.0, 205331.0, 205710.0, 205855.0, 25583.104591339215, 37099.44350834793, 37433.25133497261, 37453.25093498169, 37684.246315074095, 30142.397152057274, 30551.0, 30862.382752345275, 30888.53667194949, 31110.377792444477, 28160.155195344174, 28232.85883570569, 28703.425931480837, 28846.134615961553, 28965.42069158563, 26302.473950521264, 26872.462550749267, 26985.57129858322, 27219.59170612482, 27527.31181720473, 29220.123396298146, 29225.269368265963, 29341.119766407042, 29478.0, 29504.0, 28328.433431330846, 29703.108906732832, 31015.53476697806, 31287.217819554695, 31308.843455782575, 23525.88237058804, 24793.752062479143, 25458.236252912444, 25745.742542575084, 26245.606315905658], "unit": "score", "name": "ext.html", "value": 15844.027220008273}, {"lowerIsBetter": false, "replicates": [321.33644025088194, 336.8938784282951, 337.03103577215506, 337.93072420153874, 341.6839423533231, 11839.585614503494, 12336.198147120453, 14015.509457169, 14529.78205326921, 14627.78058329126, 9336.626534938612, 9717.416954982687, 9719.125278724914, 13172.275524846129, 14945.0, 4490.9550904491025, 4637.6289896808175, 4699.412573428322, 4699.765011749416, 4701.694389864648, 4789.760511974405, 4904.779284932169, 5001.349824522825, 5008.874778130539, 5014.022265658198, 4810.470848206694, 4984.32711583937, 4996.600271978251, 5009.198528235483, 5019.52314530119, 5191.714455704935, 5202.739863006872, 5221.556167725748, 5229.241759944786, 5237.973810130944, 4630.073985202939, 4828.613710903154, 4835.806567737286, 4850.490698476645, 4858.514148585148, 10840.0, 14312.856871431257, 17177.65644687112, 17655.205515751695, 17738.645227095385, 1734.6964281250857, 1752.7633769441218, 1765.0760670868815, 1766.2316892151955, 1848.9537761555935, 8447.155284471564, 8687.34844886636, 8775.385722999392, 8820.426672266347, 8857.911420885774, 1707.0611163859828, 1744.4069016534313, 1771.3711632370453, 1802.9368972086045, 1851.0929644474245, 43147.78426107881, 44434.99999999968, 48012.0, 48807.51192488065, 50186.74906625444, 8871.66924961261, 9135.0, 9149.634014639472, 9236.815263694689, 9265.72202833916, 11680.766384672259, 11746.29522228669, 11764.70588235301, 11783.410829458493, 11865.644030679094, 5891.23413956183, 6135.570510064253, 6135.662538560422, 6258.468030217483, 6437.066625339299, 5930.792422265286, 5936.5250779937505, 5962.701864906738, 6017.18767966319, 6030.969845150747, 3884.495015648004, 3995.260876737813, 4018.477597912311, 4079.8164082616354, 4104.076582768913, 1586.6747316800029, 1637.321745211168, 1645.489898131583, 1669.5074952888926, 1678.093829332147, 713.7180813578607, 719.8956151358024, 757.2427572427572, 773.6402572803561, 783.9725609603637, 13647.249401283025, 13706.24615646149, 13916.51292204768, 13979.231142287272, 14027.78958315626, 759.2635143910509, 765.2347652347653, 765.2997507280776, 778.1440415542858, 828.88810010649, 7820.84358312842, 7901.288884000468, 7924.088729796147, 7972.242636949481, 8417.663293468193, 425773.0, 434079.0, 435836.0, 440886.0, 441155.0, 61354.38645613576, 64095.0, 64504.35495645077, 65190.348096519374, 65223.67388163029, 1038.672818062308, 1047.7799662070897, 1050.3855244681795, 1064.1380481809758, 1078.0190027075323, 12446.751064978831, 13055.543055992996, 13325.200487970753, 13500.189988600716, 13952.58142255734, 26896.59655105136, 27499.17502474929, 28079.578806317513, 28182.15453536397, 28553.28616784597, 37064.44403334006, 37158.44262336121, 37338.0, 37562.746235225975, 39035.41446878356, 5971.58198926071, 6056.424639659225, 6243.43809057187, 6293.748250070129, 6415.486761059011, 7530.623468826647, 8497.702580409903, 8898.377113602244, 9047.050059743633, 9272.397294175857, 7869.527828330319, 8113.229243221885, 8153.510789352657, 8179.713710020121, 8186.590670466572, 7478.813029674302, 7500.811830240183, 7636.31273185416, 7756.8448631028195, 7756.8448631028195, 7806.102298235775, 7876.133625301098, 7987.840243194987, 8154.510729356258, 8173.836523269382, 6298.874022519615, 6310.652914089769, 6311.084892690626, 6333.524985626004, 6450.193725784277, 7368.0, 7539.359154471931, 8401.537915414467, 8654.134586541295, 8773.692920747742], "unit": "score", "name": "jquery.html", "value": 7010.911736551806}, {"lowerIsBetter": false, "replicates": [1170.2802776292576, 1175.1891195075398, 1200.657812523431, 1635.4766474728092, 1658.0, 6223.564350495467, 6363.1727875376255, 7157.677904494297, 7344.192138864721, 7394.519356241841, 6674.065630811678, 6798.388145066943, 6891.414229790461, 6906.896396554043, 6913.516053876231, 1941.7766956799971, 1975.7036444533292, 1977.831884289837, 1979.3171355882268, 1979.703044543323, 1947.289239427613, 1956.628240634282, 1967.8819270843724, 2030.4213299209728, 2037.4295197344768, 2047.7133201351824, 2047.9180832766672, 2055.157385471957, 2060.9896950515226, 2074.7199128117663, 2063.1850419084453, 2064.6799746039387, 2067.390119914629, 2070.285751415759, 2071.5028393185603, 1973.6644770389069, 1998.530345368837, 2013.7784843667184, 2015.5968806238811, 2019.9596008079902, 6862.279460656609, 6910.896336554905, 6937.167539895195, 6941.826454338631, 6968.825779355506, 3979.462772525701, 4066.9593304066875, 4076.0217547788616, 4082.632563069338, 4089.7750623715683, 2600.9349766255805, 2606.2962999989895, 2630.092618046771, 2656.1633085577982, 2662.6671666041743, 832.8375966686499, 849.6728759427665, 867.1415298854089, 871.1114663043724, 890.1810334492283, 9835.803283934281, 9856.260780441495, 9885.406875587416, 9891.010898910123, 9901.207903367786, 3721.2371463849845, 3734.6825519830577, 3759.191773768653, 3773.8679146230297, 3811.8284677189595, 8378.162183781573, 8407.201315874981, 8423.284020858173, 8425.536595487185, 8454.112318206622, 4134.111166099243, 4134.793260337031, 4142.2751018572235, 4149.419081328617, 4159.688023398257, 3208.9839550802562, 3304.074859039473, 3713.5729391119826, 3763.717721170923, 3807.9619203807606, 3215.758818088653, 3273.083536609753, 3299.851506682157, 3303.4714445688574, 3309.5035744638017, 1019.1235537437798, 1023.2888142740724, 1029.0, 1029.8712660917386, 1036.3212096076932, 983.5180761426849, 1006.3559322033905, 1008.6469735592631, 1046.1160319529986, 1110.5002748763088, 6508.251551071593, 6639.037339585733, 6647.567908085959, 6665.500087493458, 6687.197536295578, 956.9712908612753, 970.6942313171328, 979.3438396274513, 983.6114734679761, 993.6174572789528, 4884.511548845087, 4937.530934561211, 4994.076095922266, 5020.422651395063, 5022.045811295842, 8331.83336333282, 8555.828883422297, 8609.053004169537, 8687.131286871263, 8690.217880390795, 8471.534065626449, 8547.529885856213, 8575.914240857637, 8584.098669639723, 8617.310615150773, 6554.246261679968, 6682.632455214913, 6714.29499902513, 6768.526203165731, 6784.966075169691, 6390.201224846895, 6411.262704789009, 6412.487001039999, 6418.582792118497, 6428.646424446701, 7573.129090154703, 7657.9617101916365, 7667.808304792425, 7695.153533111466, 7800.765977020698, 7749.108852482037, 7867.527948323119, 7900.6049697513745, 7917.643706033127, 7933.8413231736195, 5402.51377376038, 5517.393086760533, 6024.3975602439405, 6158.414950579688, 6256.186695729526, 6523.217213934358, 6736.056952026622, 6771.458283337222, 6772.661366931732, 6795.694193761392, 5839.772670621598, 6020.8795824084145, 6036.7283472244735, 6075.848103797441, 6093.939060609515, 6352.745890164527, 6411.935880641134, 6461.0, 6470.38531339522, 6510.869782604226, 6341.112244285711, 6346.4605508532295, 6407.1350367701625, 6408.455281301141, 6409.807705768834, 5850.882982340415, 5867.911981320198, 5870.090136028923, 5877.970610146922, 5890.410958904075, 6042.274927008787, 6054.424829641177, 6057.273127224761, 6063.636181828928, 6086.178365920544], "unit": "score", "name": "mootools.html", "value": 3999.5629472861374}, {"lowerIsBetter": false, "replicates": [281.19578006900264, 282.9292676830792, 285.995710064349, 290.5293424652064, 296.6514345643868, 5448.91826622601, 5635.380108188096, 5704.942950570498, 5726.112452569853, 5810.477057064863, 5622.128570071635, 5669.886602267952, 5672.290963629546, 5675.5459563234945, 5688.118341657039, 4270.1886641538085, 4270.444842170514, 4272.9359059614135, 4286.935695964563, 4301.204277208711, 4269.551697071794, 4278.229918614648, 4285.271503844354, 4287.742735435884, 4292.871213863574, 3960.3861401482673, 4132.297509423405, 4171.958280417188, 4247.872563823074, 4253.936190957138, 4149.439825623533, 4155.293600087962, 4164.8125834337525, 4168.603982621661, 4179.080602267496, 3555.1112221944513, 3556.733245006609, 3557.1640664443835, 3571.0, 3572.624874388204, 5358.892822143535, 5369.382521010095, 5390.434004429557, 5393.7572809223675, 5400.891982160374, 4601.493835678073, 4748.477667456577, 4767.332573439721, 4777.474477807438, 4792.712437253741, 5673.489385955242, 5845.620034697774, 5917.763289468416, 5920.111983202511, 5943.019401798698, 3840.884773456773, 3842.1163132479405, 3845.5193100862393, 3854.9421758673643, 3870.9032274193087, 6149.385061493859, 6178.0, 6219.844503887393, 6219.968900155515, 6241.9999999999545, 3824.0, 3938.0548668319398, 3938.8030598469963, 3966.801659916993, 3968.583298753589, 3987.322155233617, 3989.2420440116284, 3998.8400463981698, 4018.015586181346, 4020.43713880057, 4701.294805779092, 4748.3114948332295, 4748.382710247714, 4750.477447480775, 4751.976240118846, 5835.445632664975, 5853.326867410217, 5872.559558033165, 5875.823725288248, 5888.4700376966275, 1388.1532265318149, 1392.262101086426, 1422.1040744331005, 1423.5088894331438, 1423.5800438870558, 902.9683961061331, 921.953902304882, 926.7312479380904, 934.3179478980383, 935.8502639577634, 5078.187490001582, 5099.286099946011, 5101.744912754348, 5102.311187989574, 5108.106081435734, 6027.36712645166, 6051.757929682852, 6069.180660610761, 6075.422834830684, 6079.8480037998515, 5072.771725272371, 5077.213031980049, 5081.034603425337, 5085.618578606619, 5085.64400491962, 3199.808011519316, 3263.902082937516, 3281.2945216778508, 3299.0, 3322.850471728778, 5813.302403711497, 5815.505682017076, 5819.621724587888, 5824.912626310609, 5834.299884013945, 6348.746050158034, 6379.106925030499, 6386.904196437057, 6397.488200943913, 6398.488120950313, 5736.713164341766, 5813.331466881363, 5826.650400975955, 5882.823515294548, 5885.117232415172, 6151.507879369729, 6174.598651087665, 6178.938210617836, 6180.103884936749, 6217.533684973555, 6018.51851851842, 6037.637741735334, 6042.063480160582, 6046.0, 6051.667158306159, 5636.774529018793, 5790.189373487631, 5810.244668193108, 5810.448007439287, 5842.240508734008, 3950.743201691881, 3999.220152070435, 4023.2556976959354, 4024.6981476389974, 4030.8387664493093, 6177.444030037139, 6180.134781130735, 6185.783497577563, 6186.659733714509, 6189.0, 5877.882442351214, 5919.4080591940465, 5920.970395147997, 5926.0, 5926.525877929842, 5717.885642287048, 5884.852878678067, 5950.285965684146, 5953.732082056231, 5954.672493012926, 5722.141678748221, 5817.185594016756, 5818.418158184148, 5819.098039803837, 5843.590948633725, 5975.0, 5978.402159784161, 5981.551383646157, 5982.4316689914385, 5992.760289588367, 5674.546036317167, 5789.652620842763, 5794.884102318014, 5797.594168408171, 5801.245838041028], "unit": "score", "name": "prototype.html", "value": 4338.891774139252}, {"lowerIsBetter": false, "replicates": [679.969401376938, 680.520233235569, 705.0763499815242, 709.7090193020862, 713.8393861381193, 10845.295055821367, 10958.28771129876, 10988.0, 10992.395418251994, 11027.17296202784, 10620.0, 12021.699457513545, 12315.568955086574, 12350.567730129447, 12371.628851134481, 555.6305057137009, 565.9037963546207, 575.5108158065652, 613.4632196827775, 728.1953441447204, 732.4543215304606, 742.5396254322301, 747.8952946587482, 752.0524139584136, 753.5215138387109, 743.323575546253, 752.0148605327012, 767.4282659418712, 768.8769796832507, 772.474717192309, 765.2921048030578, 767.1791183433728, 767.2365995834125, 767.8425922685836, 769.1116760142045, 569.1803802524352, 569.8518385219832, 570.1220121013635, 570.4267211452506, 572.3075079154229, 11284.943575282154, 11287.604933827359, 11291.604793832259, 11298.717532061683, 11340.206185567014, 10573.418461984587, 10870.945645271802, 10916.345019298788, 10918.836217456745, 11018.614348497764, 9115.58979845902, 9260.0, 9299.628014879398, 9419.576119074658, 9422.858657120149, 3170.8731650733944, 3189.1382983994986, 3200.679932006804, 3227.822469764162, 3255.5930508686415, 41128.38307425391, 41147.38278925818, 41290.9999999997, 41326.173476530304, 41375.1724965499, 8453.49279043247, 8459.661613535513, 8644.178803013703, 8811.955940220258, 8954.552272386354, 14471.204083775283, 14574.417023318949, 14592.343344549521, 14609.0, 14615.488457903923, 5945.791897283574, 6001.849953751103, 6059.0608455689435, 6114.694265286718, 6128.724207410677, 3500.807455589967, 3511.0, 3524.5946716127974, 3533.964660353415, 3577.159367548624, 2527.0, 2531.886065127074, 2556.0, 2556.872156392173, 2557.3350928758286, 446.7900086959124, 453.35397059190524, 453.95914367706405, 458.68350837921724, 459.24912767624505, 463.9582437580634, 489.9951000490021, 501.7691861743566, 552.2875490617139, 570.823044856096, 7030.402415794715, 7041.5775053496955, 7069.823254418578, 7152.713891444388, 7177.066981292399, 426.32853256121734, 452.8279253883503, 458.04024210698327, 511.1208720999874, 577.6765011593521, 3321.9169520762175, 3473.4442489201606, 3564.0198945289735, 3581.0331210573, 3687.778733276012, 41562.1687566247, 44842.55157448449, 44859.10281794411, 44879.55120448819, 44892.3266151008, 39828.402573961415, 39847.0, 40002.59997399989, 40475.0, 40652.18695626071, 37653.43519847204, 37678.623213768056, 38209.426858597144, 38758.22483550313, 39364.803175983936, 7530.698772049057, 7536.107393275768, 7597.164311925573, 7624.5425274483705, 7732.110807257012, 28244.576331354634, 28800.85599571989, 29119.126426207247, 29206.56190157107, 29643.0, 34867.293667556645, 34926.30147397089, 39276.803615981735, 39364.60635393724, 39573.0, 8729.258013068706, 9027.4132181408, 9144.277370448614, 9267.119623635745, 9291.6283348668, 10412.375257484575, 10503.579856805642, 10539.525721342405, 10600.664531147399, 10806.35161890289, 10109.545070471993, 10182.439965801952, 10297.588096476056, 10496.68509944703, 10770.676879693621, 9869.407835529892, 9896.703098907044, 9923.603055877684, 10002.199824013916, 10012.39925604466, 9697.127258546765, 9814.116729494379, 9853.655122070693, 10254.384736915808, 10444.529996150039, 8100.2304781045705, 8141.633626486704, 8333.250007499355, 8482.279006284534, 8599.097094805205, 8103.797405064921, 8284.50292982423, 8289.917100829156, 8367.707130250412, 8415.513486846945], "unit": "score", "name": "yui.html", "value": 5343.5003237208075}], "name": "dromaeo_css", "value": 5991.175663671236}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 115.0, 115.0, 115.0, 125.0, 114.0, 113.0, 115.0, 112.0], "unit": "score", "name": "ai-astar", "value": 114.6}, {"lowerIsBetter": true, "replicates": [154.0, 139.0, 156.0, 171.0, 139.0, 159.0, 158.0, 143.0, 170.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.2}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 163.0, 164.0, 164.0, 164.0, 167.0, 160.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 73.0, 76.0, 73.0, 157.0, 75.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 136.0, 98.0, 99.0, 98.0, 142.0, 97.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 68.0, 70.0, 74.0, 70.0, 70.0, 70.0, 68.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 70.1}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 83.0, 68.0, 72.0, 68.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 87.0, 86.0, 84.0, 84.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [135.0, 118.0, 130.0, 129.0, 123.0, 132.0, 123.0, 140.0, 129.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.5}, {"lowerIsBetter": true, "replicates": [144.0, 166.0, 151.0, 151.0, 144.0, 149.0, 160.0, 153.0, 152.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 71.0, 81.0, 71.0, 71.0, 70.0, 70.0, 70.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1552.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [187.30099269526127], "unit": "score", "name": "DeltaBlue", "value": 353.0040020000002}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1101.3215859030836], "unit": "score", "name": "RayTrace", "value": 671.910012}, {"lowerIsBetter": false, "replicates": [705.4263565891473], "unit": "score", "name": "Earley", "value": 944.766230769231}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [42638.29787234042], "unit": "score", "name": "RegExp", "value": 21.365416666666672}, {"lowerIsBetter": false, "replicates": [600.2400960384153], "unit": "score", "name": "Splay", "value": 135.764006}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20289.86008698639}]} 07:33:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20289.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1552.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5991.17"}}} 07:33:24 INFO - Return code: 0 07:33:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:33:24 INFO - # TBPL SUCCESS # 07:33:24 INFO - Running post-action listener: _resource_record_post_action 07:33:24 INFO - Running post-run listener: _resource_record_post_run 07:33:25 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 539746304; Read time: 0; Write time: 395060 07:33:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 230019072; Read time: 0; Write time: 219552 07:33:25 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 309727232; Read time: 0; Write time: 175508 07:33:25 INFO - Running post-run listener: _upload_blobber_files 07:33:25 INFO - Blob upload gear active. 07:33:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:33:25 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 07:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:33:25 INFO - (blobuploader) - INFO - Open directory for files ... 07:33:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:33:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:33:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:27 INFO - (blobuploader) - INFO - Done attempting. 07:33:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:33:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:33:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:28 INFO - (blobuploader) - INFO - Done attempting. 07:33:28 INFO - (blobuploader) - INFO - Iteration through files over. 07:33:28 INFO - Return code: 0 07:33:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:33:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:33:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b787b9502e7757d49cc00ba3a2f9fd242099ac949effc16f4063cc7a945e5e3cd66d146123e3245c663e365a5029fbc786fc8f6d55f3ffc2e92d24e456c0cbef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc51233dc3a690a381475192c436c36ccf85a6a0960a0a32d13fc4c41a999fae1070fecf881ae51b8ecf5445a14ce4a40527147250a46fc6a52cac121f408c92"} 07:33:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:33:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:33:28 INFO - Contents: 07:33:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b787b9502e7757d49cc00ba3a2f9fd242099ac949effc16f4063cc7a945e5e3cd66d146123e3245c663e365a5029fbc786fc8f6d55f3ffc2e92d24e456c0cbef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc51233dc3a690a381475192c436c36ccf85a6a0960a0a32d13fc4c41a999fae1070fecf881ae51b8ecf5445a14ce4a40527147250a46fc6a52cac121f408c92"} 07:33:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:33:28 INFO - Copying logs to upload dir... 07:33:28 INFO - mkdir: /builds/slave/test/build/upload/logs 07:33:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.699238 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-15 07:33:28.360038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 07:33:28.364036) ========= 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=4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b787b9502e7757d49cc00ba3a2f9fd242099ac949effc16f4063cc7a945e5e3cd66d146123e3245c663e365a5029fbc786fc8f6d55f3ffc2e92d24e456c0cbef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc51233dc3a690a381475192c436c36ccf85a6a0960a0a32d13fc4c41a999fae1070fecf881ae51b8ecf5445a14ce4a40527147250a46fc6a52cac121f408c92"} build_url:https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/EPAaOCTyQUC3DxXI5n5yUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b787b9502e7757d49cc00ba3a2f9fd242099ac949effc16f4063cc7a945e5e3cd66d146123e3245c663e365a5029fbc786fc8f6d55f3ffc2e92d24e456c0cbef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc51233dc3a690a381475192c436c36ccf85a6a0960a0a32d13fc4c41a999fae1070fecf881ae51b8ecf5445a14ce4a40527147250a46fc6a52cac121f408c92"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 07:33:28.392212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:33:28.392565) ========= 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=4dd8011cc2821079d74a932a000001ae-1452870176.327868-542293564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:33:28.476964) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 07:33:28.477317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 07:33:28.477680) ========= ========= Total master_lag: 0.27 =========