builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1452684986.35 results: success (0) buildid: 20160113025731 builduid: aeec3c83a5ca40f3b157ee5cb094f1a4 revision: b3e626983fe5cd35a8546086f519d683e0f3ddd9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.351454) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.351849) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.352160) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.395356) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.395632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.424828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.425084) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.484214) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.484481) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.484809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.485089) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 03:36:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.3M=0s 2016-01-13 03:36:27 (78.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.662968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.663256) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021231 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.712857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:26.713172) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b3e626983fe5cd35a8546086f519d683e0f3ddd9 --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 b3e626983fe5cd35a8546086f519d683e0f3ddd9 --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=74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 03:36:27,458 truncating revision to first 12 chars 2016-01-13 03:36:27,458 Setting DEBUG logging. 2016-01-13 03:36:27,458 attempt 1/10 2016-01-13 03:36:27,458 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b3e626983fe5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 03:36:27,734 unpacking tar archive at: fx-team-b3e626983fe5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.958462 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:27.685652) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:27.685964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:27.694382) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:27.694660) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 03:36:27.695078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-01-13 03:36:27.695382) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:36:28 INFO - MultiFileLogger online at 20160113 03:36:28 in /builds/slave/test 03:36:28 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 03:36:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:28 INFO - {'append_to_log': False, 03:36:28 INFO - 'base_work_dir': '/builds/slave/test', 03:36:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:36:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:28 INFO - 'branch': 'Fx-Team-Non-PGO', 03:36:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:28 INFO - 'config_files': ('talos/linux_config.py',), 03:36:28 INFO - 'default_actions': ('clobber', 03:36:28 INFO - 'read-buildbot-config', 03:36:28 INFO - 'download-and-extract', 03:36:28 INFO - 'populate-webroot', 03:36:28 INFO - 'create-virtualenv', 03:36:28 INFO - 'install', 03:36:28 INFO - 'run-tests'), 03:36:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:28 INFO - 'download_minidump_stackwalk': True, 03:36:28 INFO - 'download_symbols': 'ondemand', 03:36:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:28 INFO - 'installer_path': 'installer.exe', 03:36:28 INFO - 'log_level': 'info', 03:36:28 INFO - 'log_name': 'talos', 03:36:28 INFO - 'log_to_console': True, 03:36:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:36:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:36:28 INFO - 'opt_config_files': (), 03:36:28 INFO - 'pip_index': False, 03:36:28 INFO - 'sps_profile': False, 03:36:28 INFO - 'sps_profile_interval': 0, 03:36:28 INFO - 'suite': 'dromaeojs-e10s', 03:36:28 INFO - 'system_bits': '32', 03:36:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:28 INFO - 'title': 'talos-linux64-ix-042', 03:36:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:28 INFO - 'use_talos_json': True, 03:36:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:28 INFO - 'work_dir': 'build'} 03:36:28 INFO - ##### 03:36:28 INFO - ##### Running clobber step. 03:36:28 INFO - ##### 03:36:28 INFO - Running pre-action listener: _resource_record_pre_action 03:36:28 INFO - Running main action method: clobber 03:36:28 INFO - rmtree: /builds/slave/test/build 03:36:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:28 INFO - Running post-action listener: _resource_record_post_action 03:36:28 INFO - ##### 03:36:28 INFO - ##### Running read-buildbot-config step. 03:36:28 INFO - ##### 03:36:28 INFO - Running pre-action listener: _resource_record_pre_action 03:36:28 INFO - Running main action method: read_buildbot_config 03:36:28 INFO - Using buildbot properties: 03:36:28 INFO - { 03:36:28 INFO - "project": "", 03:36:28 INFO - "product": "firefox", 03:36:28 INFO - "script_repo_revision": "production", 03:36:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:36:28 INFO - "repository": "", 03:36:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:36:28 INFO - "buildid": "20160113025731", 03:36:28 INFO - "pgo_build": "False", 03:36:28 INFO - "basedir": "/builds/slave/test", 03:36:28 INFO - "buildnumber": 949, 03:36:28 INFO - "slavename": "talos-linux64-ix-042", 03:36:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:36:28 INFO - "platform": "ubuntu64_hw", 03:36:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:36:28 INFO - "branch": "fx-team", 03:36:28 INFO - "repo_path": "integration/fx-team", 03:36:28 INFO - "revision": "b3e626983fe5cd35a8546086f519d683e0f3ddd9", 03:36:28 INFO - "stage_platform": "linux64", 03:36:28 INFO - "builduid": "aeec3c83a5ca40f3b157ee5cb094f1a4", 03:36:28 INFO - "slavebuilddir": "test" 03:36:28 INFO - } 03:36:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:36:28 INFO - Running post-action listener: _resource_record_post_action 03:36:28 INFO - ##### 03:36:28 INFO - ##### Running download-and-extract step. 03:36:28 INFO - ##### 03:36:28 INFO - Running pre-action listener: _resource_record_pre_action 03:36:28 INFO - Running main action method: download_and_extract 03:36:28 INFO - mkdir: /builds/slave/test/build/tests 03:36:28 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')]} 03:36:28 INFO - https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:36:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/test_packages.json 03:36:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/test_packages.json 03:36:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:36:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:36:38 INFO - Downloaded 1302 bytes. 03:36:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:36:38 INFO - Using the following test package requirements: 03:36:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:36:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:38 INFO - u'jsshell-linux-x86_64.zip'], 03:36:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:36:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:36:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:36:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:36:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:36:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:38 INFO - https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:36:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:36:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:36:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/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 03:36:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/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 03:36:47 INFO - Downloaded 22758864 bytes. 03:36:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:36:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:36:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:36:48 INFO - Return code: 0 03:36:48 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 03:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:48 INFO - https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:36:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:36:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:36:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/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 03:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/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 03:36:51 INFO - Downloaded 22758864 bytes. 03:36:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:36:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:36:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:36:52 INFO - Return code: 0 03:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:52 INFO - https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:36:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/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 03:36:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/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 03:36:56 INFO - Downloaded 11132285 bytes. 03:36:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 03:36:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:36:56 INFO - Return code: 0 03:36:56 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')]} 03:36:56 INFO - https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:36:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:36:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:36:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/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 03:36:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGH54teAQRG6cUu_tUrzdg/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 03:37:05 INFO - Downloaded 53868803 bytes. 03:37:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:37:05 INFO - mkdir: /builds/slave/test/properties 03:37:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:37:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:37:05 INFO - Contents: 03:37:05 INFO - build_url:https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:37:05 INFO - Running post-action listener: _resource_record_post_action 03:37:05 INFO - Running post-action listener: set_extra_try_arguments 03:37:05 INFO - ##### 03:37:05 INFO - ##### Running populate-webroot step. 03:37:05 INFO - ##### 03:37:05 INFO - Running pre-action listener: _resource_record_pre_action 03:37:05 INFO - Running main action method: populate_webroot 03:37:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:37:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:37:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:37:05 INFO - '--tppagecycles', 03:37:05 INFO - '7'], 03:37:05 INFO - 'tests': ['tsvgm']}}, 03:37:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:37:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:37:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:37:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:37:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:37:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:37:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:05 INFO - 'talos_options': ['--e10s'], 03:37:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:05 INFO - 'tests': ['damp', 'tps']}, 03:37:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:05 INFO - 'talos_options': ['--e10s'], 03:37:05 INFO - 'tests': ['damp', 'tps']}, 03:37:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:37:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:37:05 INFO - 'other': {'tests': ['a11yr', 03:37:05 INFO - 'ts_paint', 03:37:05 INFO - 'tpaint', 03:37:05 INFO - 'sessionrestore', 03:37:05 INFO - 'sessionrestore_no_auto_restore']}, 03:37:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:37:05 INFO - 'tests': ['a11yr', 03:37:05 INFO - 'ts_paint', 03:37:05 INFO - 'tpaint', 03:37:05 INFO - 'sessionrestore', 03:37:05 INFO - 'sessionrestore_no_auto_restore']}, 03:37:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:37:05 INFO - 'tests': ['a11yr', 03:37:05 INFO - 'ts_paint', 03:37:05 INFO - 'tpaint', 03:37:05 INFO - 'sessionrestore', 03:37:05 INFO - 'sessionrestore_no_auto_restore']}, 03:37:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:37:05 INFO - 'tests': ['a11yr', 03:37:05 INFO - 'ts_paint', 03:37:05 INFO - 'tpaint', 03:37:05 INFO - 'sessionrestore', 03:37:05 INFO - 'sessionrestore_no_auto_restore']}, 03:37:05 INFO - 'other_l64': {'tests': ['a11yr', 03:37:05 INFO - 'ts_paint', 03:37:05 INFO - 'tpaint', 03:37:05 INFO - 'sessionrestore', 03:37:05 INFO - 'sessionrestore_no_auto_restore']}, 03:37:05 INFO - 'other_nol64': {'tests': ['a11yr', 03:37:05 INFO - 'ts_paint', 03:37:05 INFO - 'tpaint', 03:37:05 INFO - 'sessionrestore', 03:37:05 INFO - 'sessionrestore_no_auto_restore']}, 03:37:05 INFO - 'svgr': {'tests': ['tsvgx', 03:37:05 INFO - 'tsvgr_opacity', 03:37:05 INFO - 'tart', 03:37:05 INFO - 'tscrollx', 03:37:05 INFO - 'cart']}, 03:37:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:37:05 INFO - 'tests': ['tsvgx', 03:37:05 INFO - 'tsvgr_opacity', 03:37:05 INFO - 'tart', 03:37:05 INFO - 'tscrollx', 03:37:05 INFO - 'cart']}, 03:37:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:05 INFO - 'tests': ['tp5o']}, 03:37:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:05 INFO - 'talos_options': ['--e10s'], 03:37:05 INFO - 'tests': ['tp5o']}, 03:37:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:05 INFO - 'talos_options': ['--xperf_path', 03:37:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:05 INFO - 'tests': ['tp5n']}, 03:37:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:05 INFO - 'talos_options': ['--e10s', 03:37:05 INFO - '--xperf_path', 03:37:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:05 INFO - 'tests': ['tp5n']}}, 03:37:05 INFO - 'talos.zip': {'path': '', 03:37:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:37:05 INFO - Running post-action listener: _resource_record_post_action 03:37:05 INFO - ##### 03:37:05 INFO - ##### Running create-virtualenv step. 03:37:05 INFO - ##### 03:37:05 INFO - Running pre-action listener: _resource_record_pre_action 03:37:05 INFO - Running main action method: create_virtualenv 03:37:05 INFO - Creating virtualenv /builds/slave/test/build/venv 03:37:05 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 03:37:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:37:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:37:05 INFO - Using real prefix '/usr' 03:37:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:37:05 INFO - Installing distribute.............................................................................................................................................................................................done. 03:37:07 INFO - Installing pip.................done. 03:37:07 INFO - Return code: 0 03:37:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:07 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 0x7ffbcd4e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', '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 03:37:07 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 03:37:07 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 03:37:07 INFO - Using env: {'DISPLAY': ':0', 03:37:07 INFO - 'HOME': '/home/cltbld', 03:37:07 INFO - 'LANG': 'en_US.UTF-8', 03:37:07 INFO - 'LANGUAGE': 'en_US:en', 03:37:07 INFO - 'LOGNAME': 'cltbld', 03:37:07 INFO - 'MAIL': '/var/mail/cltbld', 03:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:07 INFO - 'MOZ_NO_REMOTE': '1', 03:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:07 INFO - 'NO_EM_RESTART': '1', 03:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:07 INFO - 'PWD': '/builds/slave/test', 03:37:07 INFO - 'SHELL': '/bin/bash', 03:37:07 INFO - 'SHLVL': '1', 03:37:07 INFO - 'TERM': 'linux', 03:37:07 INFO - 'TMOUT': '86400', 03:37:07 INFO - 'USER': 'cltbld', 03:37:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:07 INFO - '_': '/tools/buildbot/bin/python'} 03:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:08 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 03:37:08 INFO - Cleaning up... 03:37:08 INFO - Return code: 0 03:37:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffbcd4e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', '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 03:37:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:37:08 INFO - Using env: {'DISPLAY': ':0', 03:37:08 INFO - 'HOME': '/home/cltbld', 03:37:08 INFO - 'LANG': 'en_US.UTF-8', 03:37:08 INFO - 'LANGUAGE': 'en_US:en', 03:37:08 INFO - 'LOGNAME': 'cltbld', 03:37:08 INFO - 'MAIL': '/var/mail/cltbld', 03:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:08 INFO - 'MOZ_NO_REMOTE': '1', 03:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:08 INFO - 'NO_EM_RESTART': '1', 03:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:08 INFO - 'PWD': '/builds/slave/test', 03:37:08 INFO - 'SHELL': '/bin/bash', 03:37:08 INFO - 'SHLVL': '1', 03:37:08 INFO - 'TERM': 'linux', 03:37:08 INFO - 'TMOUT': '86400', 03:37:08 INFO - 'USER': 'cltbld', 03:37:08 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:08 INFO - '_': '/tools/buildbot/bin/python'} 03:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:08 INFO - Downloading/unpacking psutil>=0.7.1 03:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:37:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:10 INFO - Installing collected packages: psutil 03:37:10 INFO - Running setup.py install for psutil 03:37:10 INFO - building 'psutil._psutil_linux' extension 03:37:10 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 03:37:10 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 03:37:10 INFO - building 'psutil._psutil_posix' extension 03:37:10 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 03:37:10 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 03:37:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:10 INFO - Successfully installed psutil 03:37:10 INFO - Cleaning up... 03:37:10 INFO - Return code: 0 03:37:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffbcd4e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', '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 03:37:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:37:10 INFO - Using env: {'DISPLAY': ':0', 03:37:10 INFO - 'HOME': '/home/cltbld', 03:37:10 INFO - 'LANG': 'en_US.UTF-8', 03:37:10 INFO - 'LANGUAGE': 'en_US:en', 03:37:10 INFO - 'LOGNAME': 'cltbld', 03:37:10 INFO - 'MAIL': '/var/mail/cltbld', 03:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:10 INFO - 'MOZ_NO_REMOTE': '1', 03:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:10 INFO - 'NO_EM_RESTART': '1', 03:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:10 INFO - 'PWD': '/builds/slave/test', 03:37:10 INFO - 'SHELL': '/bin/bash', 03:37:10 INFO - 'SHLVL': '1', 03:37:10 INFO - 'TERM': 'linux', 03:37:10 INFO - 'TMOUT': '86400', 03:37:10 INFO - 'USER': 'cltbld', 03:37:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:10 INFO - '_': '/tools/buildbot/bin/python'} 03:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:37:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:37:12 INFO - Installing collected packages: mozsystemmonitor 03:37:12 INFO - Running setup.py install for mozsystemmonitor 03:37:12 INFO - Successfully installed mozsystemmonitor 03:37:12 INFO - Cleaning up... 03:37:12 INFO - Return code: 0 03:37:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffbcd4e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', '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 03:37:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:37:12 INFO - Using env: {'DISPLAY': ':0', 03:37:12 INFO - 'HOME': '/home/cltbld', 03:37:12 INFO - 'LANG': 'en_US.UTF-8', 03:37:12 INFO - 'LANGUAGE': 'en_US:en', 03:37:12 INFO - 'LOGNAME': 'cltbld', 03:37:12 INFO - 'MAIL': '/var/mail/cltbld', 03:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:12 INFO - 'MOZ_NO_REMOTE': '1', 03:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:12 INFO - 'NO_EM_RESTART': '1', 03:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:12 INFO - 'PWD': '/builds/slave/test', 03:37:12 INFO - 'SHELL': '/bin/bash', 03:37:12 INFO - 'SHLVL': '1', 03:37:12 INFO - 'TERM': 'linux', 03:37:12 INFO - 'TMOUT': '86400', 03:37:12 INFO - 'USER': 'cltbld', 03:37:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:12 INFO - '_': '/tools/buildbot/bin/python'} 03:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:14 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:37:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:15 INFO - Downloading docopt-0.6.1.tar.gz 03:37:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:37:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:15 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:15 INFO - Running setup.py install for blobuploader 03:37:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:15 INFO - Running setup.py install for requests 03:37:15 INFO - Running setup.py install for docopt 03:37:16 INFO - Successfully installed blobuploader requests docopt 03:37:16 INFO - Cleaning up... 03:37:16 INFO - Return code: 0 03:37:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:16 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 0x7ffbcd4e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', '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 03:37:16 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 03:37:16 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 03:37:16 INFO - Using env: {'DISPLAY': ':0', 03:37:16 INFO - 'HOME': '/home/cltbld', 03:37:16 INFO - 'LANG': 'en_US.UTF-8', 03:37:16 INFO - 'LANGUAGE': 'en_US:en', 03:37:16 INFO - 'LOGNAME': 'cltbld', 03:37:16 INFO - 'MAIL': '/var/mail/cltbld', 03:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:16 INFO - 'MOZ_NO_REMOTE': '1', 03:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:16 INFO - 'NO_EM_RESTART': '1', 03:37:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:16 INFO - 'PWD': '/builds/slave/test', 03:37:16 INFO - 'SHELL': '/bin/bash', 03:37:16 INFO - 'SHLVL': '1', 03:37:16 INFO - 'TERM': 'linux', 03:37:16 INFO - 'TMOUT': '86400', 03:37:16 INFO - 'USER': 'cltbld', 03:37:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:16 INFO - '_': '/tools/buildbot/bin/python'} 03:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:16 INFO - Running setup.py (path:/tmp/pip-ghzRpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:16 INFO - Running setup.py (path:/tmp/pip-KCgqBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:16 INFO - Running setup.py (path:/tmp/pip-NuNk5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:16 INFO - Running setup.py (path:/tmp/pip-Mox1Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:16 INFO - Running setup.py (path:/tmp/pip-STOPC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:16 INFO - Running setup.py (path:/tmp/pip-oA0o4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:16 INFO - Running setup.py (path:/tmp/pip-F3je6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:16 INFO - Running setup.py (path:/tmp/pip-4FlVuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:16 INFO - Running setup.py (path:/tmp/pip-qOxzX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:16 INFO - Running setup.py (path:/tmp/pip-O569LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:17 INFO - Running setup.py (path:/tmp/pip-JhAosC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:17 INFO - Running setup.py (path:/tmp/pip-ZjrZcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:17 INFO - Running setup.py (path:/tmp/pip-asJF6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:17 INFO - Running setup.py (path:/tmp/pip-3bKEVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:17 INFO - Running setup.py (path:/tmp/pip-obqdZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:17 INFO - Running setup.py (path:/tmp/pip-4NON8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:17 INFO - Running setup.py (path:/tmp/pip-TmjH28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:17 INFO - Running setup.py install for manifestparser 03:37:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:17 INFO - Running setup.py install for mozcrash 03:37:17 INFO - Running setup.py install for mozdebug 03:37:17 INFO - Running setup.py install for mozdevice 03:37:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:17 INFO - Running setup.py install for mozfile 03:37:18 INFO - Running setup.py install for mozhttpd 03:37:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Running setup.py install for mozinfo 03:37:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Running setup.py install for mozInstall 03:37:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Running setup.py install for mozleak 03:37:18 INFO - Running setup.py install for mozlog 03:37:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Running setup.py install for moznetwork 03:37:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Running setup.py install for mozprocess 03:37:18 INFO - Running setup.py install for mozprofile 03:37:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:18 INFO - Running setup.py install for mozrunner 03:37:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:19 INFO - Running setup.py install for mozscreenshot 03:37:19 INFO - Running setup.py install for moztest 03:37:19 INFO - Running setup.py install for mozversion 03:37:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:19 INFO - Cleaning up... 03:37:19 INFO - Return code: 0 03:37:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ffbcd4e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', '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 03:37:19 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 03:37:19 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 03:37:19 INFO - Using env: {'DISPLAY': ':0', 03:37:19 INFO - 'HOME': '/home/cltbld', 03:37:19 INFO - 'LANG': 'en_US.UTF-8', 03:37:19 INFO - 'LANGUAGE': 'en_US:en', 03:37:19 INFO - 'LOGNAME': 'cltbld', 03:37:19 INFO - 'MAIL': '/var/mail/cltbld', 03:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:19 INFO - 'MOZ_NO_REMOTE': '1', 03:37:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:19 INFO - 'NO_EM_RESTART': '1', 03:37:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:19 INFO - 'PWD': '/builds/slave/test', 03:37:19 INFO - 'SHELL': '/bin/bash', 03:37:19 INFO - 'SHLVL': '1', 03:37:19 INFO - 'TERM': 'linux', 03:37:19 INFO - 'TMOUT': '86400', 03:37:19 INFO - 'USER': 'cltbld', 03:37:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:19 INFO - '_': '/tools/buildbot/bin/python'} 03:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:19 INFO - Running setup.py (path:/tmp/pip-iGv8bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:19 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)) 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:19 INFO - Running setup.py (path:/tmp/pip-Ny6bxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:19 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)) 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:19 INFO - Running setup.py (path:/tmp/pip-ax2Vg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:19 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)) 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:19 INFO - Running setup.py (path:/tmp/pip-AQVrqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:19 INFO - Running setup.py (path:/tmp/pip-Yry1vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:19 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)) 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:19 INFO - Running setup.py (path:/tmp/pip-P_zSvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:20 INFO - Running setup.py (path:/tmp/pip-QPxxFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:20 INFO - Running setup.py (path:/tmp/pip-WvrPjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:20 INFO - Running setup.py (path:/tmp/pip-jfHMe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:20 INFO - Running setup.py (path:/tmp/pip-ladWn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:20 INFO - Running setup.py (path:/tmp/pip-sdc7ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:20 INFO - Running setup.py (path:/tmp/pip-5pU31r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:20 INFO - Running setup.py (path:/tmp/pip-LXj6JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:20 INFO - Running setup.py (path:/tmp/pip-QKMbC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:20 INFO - Running setup.py (path:/tmp/pip-bByYAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:20 INFO - Running setup.py (path:/tmp/pip-UuL7Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:20 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)) 03:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:20 INFO - Running setup.py (path:/tmp/pip-Q8y9Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:20 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)) 03:37:20 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)) 03:37:20 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)) 03:37:20 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)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:20 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 03:37:20 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 03:37:20 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 03:37:20 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 03:37:20 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 03:37:20 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 03:37:22 INFO - Downloading blessings-1.5.1.tar.gz 03:37:22 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 03:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:22 INFO - Installing collected packages: blessings 03:37:22 INFO - Running setup.py install for blessings 03:37:22 INFO - Successfully installed blessings 03:37:22 INFO - Cleaning up... 03:37:23 INFO - Return code: 0 03:37:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:23 INFO - Reading from file tmpfile_stdout 03:37:23 INFO - Current package versions: 03:37:23 INFO - argparse == 1.2.1 03:37:23 INFO - blessings == 1.5.1 03:37:23 INFO - blobuploader == 1.2.4 03:37:23 INFO - docopt == 0.6.1 03:37:23 INFO - manifestparser == 1.1 03:37:23 INFO - mozInstall == 1.12 03:37:23 INFO - mozcrash == 0.16 03:37:23 INFO - mozdebug == 0.1 03:37:23 INFO - mozdevice == 0.47 03:37:23 INFO - mozfile == 1.2 03:37:23 INFO - mozhttpd == 0.7 03:37:23 INFO - mozinfo == 0.9 03:37:23 INFO - mozleak == 0.1 03:37:23 INFO - mozlog == 3.1 03:37:23 INFO - moznetwork == 0.27 03:37:23 INFO - mozprocess == 0.22 03:37:23 INFO - mozprofile == 0.28 03:37:23 INFO - mozrunner == 6.11 03:37:23 INFO - mozscreenshot == 0.1 03:37:23 INFO - mozsystemmonitor == 0.0 03:37:23 INFO - moztest == 0.7 03:37:23 INFO - mozversion == 1.4 03:37:23 INFO - psutil == 3.1.1 03:37:23 INFO - requests == 1.2.3 03:37:23 INFO - wsgiref == 0.1.2 03:37:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ffbcd4e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', '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 03:37:23 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 03:37:23 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 03:37:23 INFO - Using env: {'DISPLAY': ':0', 03:37:23 INFO - 'HOME': '/home/cltbld', 03:37:23 INFO - 'LANG': 'en_US.UTF-8', 03:37:23 INFO - 'LANGUAGE': 'en_US:en', 03:37:23 INFO - 'LOGNAME': 'cltbld', 03:37:23 INFO - 'MAIL': '/var/mail/cltbld', 03:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:23 INFO - 'MOZ_NO_REMOTE': '1', 03:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:23 INFO - 'NO_EM_RESTART': '1', 03:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:23 INFO - 'PWD': '/builds/slave/test', 03:37:23 INFO - 'SHELL': '/bin/bash', 03:37:23 INFO - 'SHLVL': '1', 03:37:23 INFO - 'TERM': 'linux', 03:37:23 INFO - 'TMOUT': '86400', 03:37:23 INFO - 'USER': 'cltbld', 03:37:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:23 INFO - '_': '/tools/buildbot/bin/python'} 03:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:23 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)) 03:37:23 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)) 03:37:23 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)) 03:37:23 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)) 03:37:23 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)) 03:37:23 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)) 03:37:23 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)) 03:37:23 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)) 03:37:23 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)) 03:37:23 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)) 03:37:23 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)) 03:37:23 INFO - Cleaning up... 03:37:23 INFO - Return code: 0 03:37:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbcd4e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', '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 03:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:37:23 INFO - Using env: {'DISPLAY': ':0', 03:37:23 INFO - 'HOME': '/home/cltbld', 03:37:23 INFO - 'LANG': 'en_US.UTF-8', 03:37:23 INFO - 'LANGUAGE': 'en_US:en', 03:37:23 INFO - 'LOGNAME': 'cltbld', 03:37:23 INFO - 'MAIL': '/var/mail/cltbld', 03:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:23 INFO - 'MOZ_NO_REMOTE': '1', 03:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:23 INFO - 'NO_EM_RESTART': '1', 03:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:23 INFO - 'PWD': '/builds/slave/test', 03:37:23 INFO - 'SHELL': '/bin/bash', 03:37:23 INFO - 'SHLVL': '1', 03:37:23 INFO - 'TERM': 'linux', 03:37:23 INFO - 'TMOUT': '86400', 03:37:23 INFO - 'USER': 'cltbld', 03:37:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:23 INFO - '_': '/tools/buildbot/bin/python'} 03:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:23 INFO - Downloading/unpacking jsonschema 03:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:25 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 03:37:25 INFO - Downloading/unpacking functools32 (from jsonschema) 03:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:25 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:25 INFO - warning: no files found matching '*.txt' 03:37:25 INFO - no previously-included directories found matching 'build' 03:37:25 INFO - no previously-included directories found matching 'dist' 03:37:25 INFO - no previously-included directories found matching '.git*' 03:37:25 INFO - Installing collected packages: jsonschema, functools32 03:37:25 INFO - Running setup.py install for functools32 03:37:26 INFO - warning: no files found matching '*.txt' 03:37:26 INFO - no previously-included directories found matching 'build' 03:37:26 INFO - no previously-included directories found matching 'dist' 03:37:26 INFO - no previously-included directories found matching '.git*' 03:37:26 INFO - Successfully installed jsonschema functools32 03:37:26 INFO - Cleaning up... 03:37:26 INFO - Return code: 0 03:37:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:37:26 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')]} 03:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:26 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')]} 03:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:26 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 0x7ffbcd4e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', '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 03:37:26 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 03:37:26 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 03:37:26 INFO - Using env: {'DISPLAY': ':0', 03:37:26 INFO - 'HOME': '/home/cltbld', 03:37:26 INFO - 'LANG': 'en_US.UTF-8', 03:37:26 INFO - 'LANGUAGE': 'en_US:en', 03:37:26 INFO - 'LOGNAME': 'cltbld', 03:37:26 INFO - 'MAIL': '/var/mail/cltbld', 03:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:26 INFO - 'MOZ_NO_REMOTE': '1', 03:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:26 INFO - 'NO_EM_RESTART': '1', 03:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:26 INFO - 'PWD': '/builds/slave/test', 03:37:26 INFO - 'SHELL': '/bin/bash', 03:37:26 INFO - 'SHLVL': '1', 03:37:26 INFO - 'TERM': 'linux', 03:37:26 INFO - 'TMOUT': '86400', 03:37:26 INFO - 'USER': 'cltbld', 03:37:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:26 INFO - '_': '/tools/buildbot/bin/python'} 03:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:26 INFO - Downloading/unpacking flake8 03:37:26 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 03:37:26 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 03:37:26 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 03:37:26 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 03:37:26 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 03:37:26 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 03:37:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:37:28 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 03:37:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:37:28 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 03:37:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 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 03:37:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:37:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:28 INFO - no previously-included directories found matching 'docs/_build' 03:37:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:37:28 INFO - Running setup.py install for pep8 03:37:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:28 INFO - no previously-included directories found matching 'docs/_build' 03:37:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:37:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:37:29 INFO - Cleaning up... 03:37:29 INFO - Return code: 0 03:37:29 INFO - Running post-action listener: _resource_record_post_action 03:37:29 INFO - Running post-action listener: _start_resource_monitoring 03:37:29 INFO - Starting resource monitoring. 03:37:29 INFO - ##### 03:37:29 INFO - ##### Running install step. 03:37:29 INFO - ##### 03:37:29 INFO - Running pre-action listener: _resource_record_pre_action 03:37:29 INFO - Running main action method: install 03:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:29 INFO - Reading from file tmpfile_stdout 03:37:29 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:29 INFO - Reading from file tmpfile_stdout 03:37:29 INFO - Output received: 03:37:29 INFO - Usage: mozinstall [options] installer 03:37:29 INFO - Options: 03:37:29 INFO - -h, --help show this help message and exit 03:37:29 INFO - -d DEST, --destination=DEST 03:37:29 INFO - Directory to install application into. [default: 03:37:29 INFO - "/builds/slave/test"] 03:37:29 INFO - --app=APP Application being installed. [default: firefox] 03:37:29 INFO - mkdir: /builds/slave/test/build/application 03:37:29 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'] 03:37:29 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 03:37:45 INFO - Reading from file tmpfile_stdout 03:37:45 INFO - Output received: 03:37:45 INFO - /builds/slave/test/build/application/firefox/firefox 03:37:45 INFO - Running post-action listener: _resource_record_post_action 03:37:45 INFO - ##### 03:37:45 INFO - ##### Running run-tests step. 03:37:45 INFO - ##### 03:37:45 INFO - Running pre-action listener: _resource_record_pre_action 03:37:45 INFO - Running main action method: run_tests 03:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:45 INFO - Python 2.7.3 03:37:45 INFO - Return code: 0 03:37:45 INFO - grabbing minidump binary from tooltool 03:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:45 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 0x172b3d0>, '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 0x1696ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1697360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:45 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 03:37:45 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 03:37:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:45 INFO - Return code: 0 03:37:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:37:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:37:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:37:46 INFO - Return code: 0 03:37:46 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/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 03:37:46 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/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 03:37:46 INFO - Using env: {'DISPLAY': ':0', 03:37:46 INFO - 'HOME': '/home/cltbld', 03:37:46 INFO - 'LANG': 'en_US.UTF-8', 03:37:46 INFO - 'LANGUAGE': 'en_US:en', 03:37:46 INFO - 'LOGNAME': 'cltbld', 03:37:46 INFO - 'MAIL': '/var/mail/cltbld', 03:37:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:46 INFO - 'MOZ_NO_REMOTE': '1', 03:37:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:46 INFO - 'NO_EM_RESTART': '1', 03:37:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:46 INFO - 'PWD': '/builds/slave/test', 03:37:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:46 INFO - 'SHELL': '/bin/bash', 03:37:46 INFO - 'SHLVL': '1', 03:37:46 INFO - 'TERM': 'linux', 03:37:46 INFO - 'TMOUT': '86400', 03:37:46 INFO - 'USER': 'cltbld', 03:37:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155', 03:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:46 INFO - '_': '/tools/buildbot/bin/python'} 03:37:46 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/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 03:37:46 INFO - mozversion application_buildid: 20160113025731 03:37:46 INFO - mozversion application_changeset: b3e626983fe5cd35a8546086f519d683e0f3ddd9 03:37:46 INFO - mozversion application_display_name: Nightly 03:37:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:46 INFO - mozversion application_name: Firefox 03:37:46 INFO - mozversion application_remotingname: firefox 03:37:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:37:46 INFO - mozversion application_vendor: Mozilla 03:37:46 INFO - mozversion application_version: 46.0a1 03:37:46 INFO - mozversion platform_buildid: 20160113025731 03:37:46 INFO - mozversion platform_changeset: b3e626983fe5cd35a8546086f519d683e0f3ddd9 03:37:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:37:46 INFO - mozversion platform_version: 46.0a1 03:37:46 INFO - using testdate: 1452685066 03:37:46 INFO - actual date: 1452685066 03:37:46 INFO - starting webserver on 'localhost:57521' 03:37:46 INFO - SUITE-START | Running 3 tests 03:37:46 INFO - TEST-START | dromaeo_css 03:37:46 INFO - operating with platform_type : linux_ 03:37:46 INFO - Initialising browser for dromaeo_css test... 03:37:46 INFO - TEST-INFO | started process 30910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwtnc_0/profile http://localhost:57521/getInfo.html) 03:37:50 INFO - PROCESS | 30910 | 03:37:50 INFO - PROCESS | 30910 | (process:30995): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:37:51 INFO - PROCESS | 30910 | __metrics Screen width/height:1600/1200 03:37:51 INFO - PROCESS | 30910 | colorDepth:24 03:37:51 INFO - PROCESS | 30910 | Browser inner width/height: 1024/697 03:37:51 INFO - PROCESS | 30910 | __metrics 03:37:51 INFO - PROCESS | 30910 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:37:52 INFO - TEST-INFO | 30910: exit 0 03:37:52 INFO - Browser initialized. 03:37:52 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:52 INFO - TEST-INFO | started process 31044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwtnc_0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:53 INFO - PROCESS | 31044 | 03:37:53 INFO - PROCESS | 31044 | (process:31105): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:04 INFO - PROCESS | 31044 | RSS: Main: 149745664 03:38:04 INFO - PROCESS | 31044 | 03:38:54 INFO - PROCESS | 31044 | 1452685134097 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] 03:41:05 INFO - PROCESS | 31044 | Cycle 1(1): loaded http://localhost:57521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57521/tests/dromaeo/cssquery-ext.html) 03:41:06 INFO - PROCESS | 31044 | RSS: Main: 153272320 03:41:06 INFO - PROCESS | 31044 | 03:44:08 INFO - PROCESS | 31044 | Cycle 1(1): loaded http://localhost:57521/tests/dromaeo/cssquery-ext.html (next: http://localhost:57521/tests/dromaeo/cssquery-jquery.html) 03:44:09 INFO - PROCESS | 31044 | RSS: Main: 150843392 03:44:09 INFO - PROCESS | 31044 | 03:47:11 INFO - PROCESS | 31044 | Cycle 1(1): loaded http://localhost:57521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57521/tests/dromaeo/cssquery-mootools.html) 03:47:11 INFO - PROCESS | 31044 | RSS: Main: 151543808 03:47:11 INFO - PROCESS | 31044 | 03:50:13 INFO - PROCESS | 31044 | Cycle 1(1): loaded http://localhost:57521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57521/tests/dromaeo/cssquery-prototype.html) 03:50:14 INFO - PROCESS | 31044 | RSS: Main: 150413312 03:50:14 INFO - PROCESS | 31044 | 03:53:16 INFO - PROCESS | 31044 | Cycle 1(1): loaded http://localhost:57521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57521/tests/dromaeo/cssquery-yui.html) 03:53:17 INFO - PROCESS | 31044 | RSS: Main: 151756800 03:53:17 INFO - PROCESS | 31044 | 03:56:19 INFO - PROCESS | 31044 | Cycle 1(1): loaded http://localhost:57521/tests/dromaeo/cssquery-yui.html (next: http://localhost:57521/tests/dromaeo/cssquery-dojo.html) 03:56:20 INFO - PROCESS | 31044 | RSS: Main: 153890816 03:56:20 INFO - PROCESS | 31044 | 03:56:20 INFO - PROCESS | 31044 | __start_tp_report 03:56:20 INFO - PROCESS | 31044 | _x_x_mozilla_page_load 03:56:20 INFO - PROCESS | 31044 | _x_x_mozilla_page_load_details 03:56:20 INFO - PROCESS | 31044 | |i|pagename|runs| 03:56:20 INFO - PROCESS | 31044 | |0;dojo.html;2634.2755742170903;2643.4845205184997;2683.18162960297;2689.394886150615;2703.148508219911;4439.134368798085;4513.887152821177;4531.7054391464535;4551.089782043597;4564.543545645433;4448.644108471322;4526.70576412533;4541.069080838429;4578.587927086562;4586.8394606188795;4192.769397683126;4219.2405367033925;4220.07158425146;4248.362745588156;4265.296226122686;4118.38224266361;4215.45199124115;4233.6824738144605;4257.467816522934;4262.72292301001;4036.0717035082093;4073.489977960982;4081.9183616327805;4114.300568903263;4151.9999999999845;4152;4162.646175075122;4178.456800615931;4178.7283826551175;4188.81150348235;4096.487939007624;4122.464079669654;4132.33882578789;4149.232392007458;4170.582941705836;4305.84929527465;4473.396091527635;4524.23088075028;4524.909501809978;4571.862844114648;4832.106060378841;4842.782074806642;4846.0550192712435;4853.635977301717;4860.465348811628;4842.2736589511505;4876.171050921352;4885.951140488585;4896.681715688469;4927.556519913189;4465.173942820588;4571.839985600522;4586.197415452282;4600.2869555218995;4625.7687115644085;4966.354373931438;4978.30303757467;4982.153033984159;4986.975065124724;5045.8738531537;4661.463931647836;4730.172219861511;4780.043991201774;4793.904121917542;4826.469088400273;4873.756312184448;4879.707217566957;4892.975535122301;4919.065377578248;4957.082939656175;4785.521447855256;4791.616670666338;4792.544708252711;4793.041391721669;4808.374911261583;4554.521775213621;4668.626509879202;4685.250359942393;4761.857144285677;4795.808167673324;3963.128111815396;3978.6021397860563;3996.86010989614;4012.8194231259663;4025.939610905839;3553.662402071799;3561.8041007744305;3562.856844710139;3585.6952159066773;3602.369585322558;4122.093139509303;4210.59999300066;4223.809928553223;4237.512686041083;4285.442892424027;4878.82924097662;4901.779419926112;4914.606831453475;4919.90160196794;4962.826301079445;4166.979090122939;4224.725392849455;4236.110416812442;4236.961944323661;4277.080427708058;4209.7474151551005;4282.850100246476;4325.6106950374615;4360.324149756792;4395.03309271966;4545.159145558082;4560.6123479503285;4566.132434837436;4582.679212455229;4600.7929643166135;4773.474917758975;4812.903741925212;4815.807367705253;4821.614270858393;4881.780319885543;4522.412086428743;4593.425821772278;4634.37435946143;4645.860624181145;4689.882752931204;4781.521847815191;4850.563449289581;4853.781579828846;4863.440704318907;4863.975680121577;4749.715017098847;4858.562729354375;4877.5366340197625;4891.31521586971;4970.652054356305;4704.976475117603;4708.270218116198;4720.150372932768;4740.170470167638;4780.354652121919;4731.124741922756;4763.476017638126;4771.976140119277;4772.49888761675;4802.615790736802;4494.617957473521;4541.364209010675;4572.474165471013;4652.581267685924;4656.534346565317;4696.882577935579;4701.0362875609735;4715.104130215248;4732.384789977281;4761.833335833229;4567.885802854955;4600.769961501978;4626.583607475343;4659.138059459011;4678.298255261738 03:56:20 INFO - PROCESS | 31044 | |1;ext.html;475.6242568370987;485.81053389178203;498.47908935162764;504.669441515807;506.4302659508052;24264;32538.511922321184;32886.34227315452;32948.835255823746;32949.83525082377;36150.27699446016;36689.26621467569;36783.4482482763;37055.25889482215;37061.44407833885;7654.9617251913805;7769.339606133485;7819.9218007820045;7824.334931530827;7837.568933708644;7535.698572057111;7688.423368247376;7709.922900770976;7715.845683086335;7887.645055972466;7853.214678532158;7938.682452701885;7947.4834135781275;7972.123066462685;7979.56112413817;7738.651760670783;7878.527288362688;7879.803004924894;7887.605619718991;7910.920890791076;7671.2712292332135;7771.766846994599;7807.258310460554;7813.218678132142;7834.059912810442;36898.81550592257;37046;37318;37353.25293494115;37432.62567374318;2728.5088684036864;2786.178077467152;2864.799464037518;3258.6089669239605;3539.911502212465;25700.357491062874;27727;27861;28265.85867070672;28741.425171496452;3399.5750531183603;3500.789952602852;3537.4693795930557;3561.056320075182;3577.874774382884;212502;212525;213054;213804.99999999846;214237;38704.419433708514;39489.802550987064;39513.40729889054;39557.80221098876;53433.198502022504;36999.445008324896;37035.25929481395;37043.07392315214;37207.069823254635;37211;12476.563320283747;12499.812502812465;12601.747965040831;12606.621801345975;12610.621681349574;9524.761880952892;9527.237820974306;9594.66418675343;9644.276679249084;9685.757856053655;13305.201687898758;13440.529581464602;13510.797338039938;13550;13587.252701101534;5464.0711079116645;5535.972320138454;5592.189132575753;5627.324721033502;5630.40880707528;847.3771777743353;872.0843114729508;938.5260443476001;965.6234068713208;979.0522575354748;26085.08702195414;26126.477470450485;27480;28376.290592735346;28856.134315970554;965.710286913923;970.8252514547308;977.3158788847835;978.9265805064506;1002.8946960569035;12090.274583525017;12528.060395470377;12648.051396145325;15204.16377099248;15920.442784502487;336288;338213;343991;344095;344954;48404.27393589028;49356.50643493519;49381.753091235034;49428.258576121385;49451.50548494541;1210.425048102162;1216.5985224875947;1219.1222319929636;1219.7560487902456;1231.150506150771;27784.722152778213;27980.580291296053;28128;28392.148235552966;28432.14703558814;39842;40160.59839401569;40264;40285;40603.390949135195;248986;252412;252680;253365;253960;28874.42251155007;42204.57795422006;43039.4500896598;43447.56552434561;43581.34627980519;36866.8156659215;37632;37918.620813792615;38888.80555597204;38957.22085558216;32160.356792863542;32396.190095247806;32886.34227315488;33090.834545827114;33688.831555842065;32509.512357315132;32652.673473264964;32701.672983270815;32733.508997365534;32739;32626.83686581552;33116;33298.83350583328;33320.50019249762;33443;28411.857940710164;28593.857030715546;29881;30970;31388.68611313949;22435.43911402163;23272.76727232706;23438.414039649146;23441.76558234396;23525 03:56:20 INFO - PROCESS | 31044 | |2;jquery.html;333.4647890136331;333.6096766782865;336.0942260607662;341.16925286926323;341.67711512620576;11873.940630296858;12279.508819647226;14133.363998620061;14490.347934342954;14790.70418591629;9471.573779179937;9727;9784.168345690625;12577;13550.864491355083;4301.827926882929;4487.035287413206;4511.6165125964335;4513.7517436540975;4517.819287228507;4202.852900148496;6025.367336429677;6343.746250149989;6347.365263473639;6358;6156.076588511714;6302.212223472066;6318.936810631881;6404.42360187583;6409.679516024204;6167;6382.904256436134;6409.8718025639455;6419.005054216604;6419.518536109764;6150.569460137747;6155.938440615581;6160.507159427235;6172.351903050205;6260.843478913018;18441.35455259073;19607;20333.694994575093;20455.386338409873;20480;1845.1604519943528;1873.1383563560642;2015.6371853066441;2026.9493262668404;2053.7330147080784;12951.87048129516;13023.674408139777;13184;13243.801342979863;13570.185788852701;1839.3838064248494;1872.5599484121221;1877.11775465531;1884.8271415108459;1915.9712604310946;53897;54681;55579;55617;56102.15846762343;14250.429982800571;14428.42286308536;14454.566363009126;14461.27693615315;14572.125672459686;21608.675869861963;21835.58068725528;21852.344429667137;21869;21911.780882190975;7922.286994170437;7929.246721561442;7936.365090792723;7972.083210430875;7973.282404583615;6338.30278669346;6340.619562826245;6372.426481616584;6524.902126468107;6569.737210511622;6191.752329906843;6525.543211975116;7164.7850564482105;7188.676509557083;7198.100237470317;2756.2558109310376;2840;2919.474494590994;2941.7205365490245;2968.168912704446;725.9854802903913;768.7309441695473;782.1865260129515;827.7930517370658;848.2196379331031;13092.607221783363;13242.205467671778;13387.732245355039;13559.389827457788;14413.49552765669;803.4737247103157;817.1909809288761;842.7598134531629;863.8661007543841;887.7691800132012;8013.519188848688;8135.75592732219;8154.429189956765;8402.453840500348;8767.342449316198;491343;494872;495582;514069;519342;59534.70232648809;64493.35506644967;65477.67261163663;66544.66727666427;68224;1073.7798751255973;1097.8188598881095;1100.2188446203124;1103.8289065194908;1106.5186643809968;9190.54047297619;12725.61823145307;13694.383752730952;13902.23537705436;14100.717985640435;29737.851310743306;30831;30845.228869278446;31968.840155799073;31979.68020319767;39868;40123.398149027205;40724.389134163604;41051.38422923599;42266.15467690567;8399.412041157304;8866.379353445196;8890.866637000321;9115.498647574183;9216.447013178962;7160.140783106061;7172.677229524579;7323;7480.551166930001;9847.556859941464;6490;6597.736090556324;6619.536632435684;6727.697253623501;6827;7051.753188638373;7085.433165346657;7179.066721326194;7200.639968001474;7276.636168191675;6720.32796720324;6756.256811750802;6806.285340039224;6813.829654258683;6956.513044087068;9405.24758019343;9464.810703786023;9593.568289426852;9594.376365536218;9678.612855485984;6117.388261173847;6238.6880655967925;8927.821443570961;9020.639174432948;9117.635294588143 03:56:20 INFO - PROCESS | 31044 | |3;mootools.html;1134.9829752553708;1139.213942379758;1200.4297958469729;1513.6594266290085;1577.8501042400967;6880.759173428931;7031.507794454384;7093.503454758169;7185.6047917364585;7195.244499327574;7174.282571742823;7207.49547531673;7285.890711639317;7286.234945330743;7291.343779059884;2148.4736239621275;2161.027537608075;2164.1127137873477;2174.521605246843;2175.1082056356895;2187.69372287879;2211.281333566589;2211.9557608847813;2219.1789038055863;2221.3669104305277;1739.3216645508262;1783.5451959750246;1978.6834106542956;2165.1231251343233;2175.760666326703;2159.222679835258;2166.7399912010583;2167.8916054197225;2175.5322605639703;2179.5096103376773;2086.467950672584;2105.3157723739846;2108.8734675919495;2111.5249068959515;2116.502621883856;6979.511434199608;7048.436125109979;7087.964560177218;7095.148582170121;7108.822279443004;4016.2168377166463;4160.687948403852;4190.371444283352;4191.601797829232;4197.958020419787;2767.266674331304;2770.9445811083665;2770.9584356234473;2781.8330900146057;2804.6634403871462;820.2699597358355;1733.9219735111951;1750.8249175082517;1754.1938374234708;1755.920983555743;9179.541022948826;9341.392809467363;9345.252379809666;9358.204552612968;9378.718638440858;3924.6271604197555;3977.5226972763453;3979.7413168143976;4034.7290603459815;4057.5130984282073;7669.884951725729;7671.501352412075;7691.384689224848;7691.884621730678;7706.884396734054;4243.893902652459;4262.360645903139;4265.338872474771;4275.764832934156;4301.0537681709975;3884.8057597120596;3917.6865850731874;3924.3524818405212;3930.3514920038447;3944.4083387492105;3085.3212293295437;3122.484790009623;3141.1361875484426;3175.3173067790535;3180.3480286541203;907.832051070554;913.2283220678516;914.6752902719572;922.1285884838898;952.6713283917038;723.4176487927269;744.9180590135081;898.8067565473455;959.5633986536109;1148.2192109365544;6192.907106393408;6402.711877965409;6512.283648798629;6512.934870651327;6519.152510173647;555.5777609017176;571.6998575747766;572.3589579670712;573.4781348972415;711.8574687626389;5022.698638081727;5083.110455670243;5094.337736094358;5108.208227724708;5131.7434128293435;8196.139405362352;9004.054574269738;9068.274538036942;9136;9214.90785092154;8850.822983540293;8915.73252802417;8916.37585369031;8920.286377089817;8925.062868398725;6723.22682891464;6734.494912881455;6740.29226931175;6783.38949494538;6841.24746277919;6603.537752357289;6641.734330626721;6668.399844013868;6680.3987641112535;6686.632235227109;7705.345045671181;7927.960360198162;7928.207179282025;7993.560354180576;7996.60016999136;8051.718189863327;8241.134680858424;8298.668053277801;8313.542755148525;8332.583370831555;5641.26663533738;5702.059160238514;5704;5709.029464991045;5735.13972904051;6276.1213430118905;6301.8109456716375;6327.209098862642;6339.397757213057;6349.77775777864;6037.275526936795;6041.9395806041375;6079;6154.692265386623;6173.536984726254;5408.3509978802795;5425.376081750492;5928.081147422156;5957.940420595739;6135.693215339126;6245.9063114052415;6269.310375858743;6307.558470906993;6313.210848643919;6332.936670633235;5733.369329373682;5912.172295878494;5927.7036148191555;5929.229200204119;5939.406059394026;5974.312954010345;5998.280206375263;6013.909791353046;6024.0662697282;6024.216851809412 03:56:20 INFO - PROCESS | 31044 | |4;prototype.html;291.50298740647196;304.6709553682024;305.3191383215428;306.22525011720353;306.4988743404534;5426.62013659044;5536.667799932002;5543.143047079223;5576.6932818695;5681.346645135811;5564.972175139129;5617.269754931853;5626.690532020737;5640.097584386499;5642.210090587311;4258.765767882765;4263.87208383749;4265.381519679645;4266.424032755569;4272.530021697627;4266.445362102922;4272.679549033819;4275.5296917339065;4276.957230427687;4283.4431523902;4062.6343629073376;4172.102997855461;4217.367394890775;4221.05026369066;4222.366645003259;4178.435911151986;4195.951012246938;4201.096764195682;4202.054537729002;4206.348016057485;3644.180059486621;3647;3652.506911566931;3656.433252845813;3660.084978755311;5325.467453254682;5362.4637536246455;5380.21986811914;5383.192521121824;5385.111456609655;4628.861134165981;4634.281686338623;4853.39332583427;4864.902701945976;4886.389201349832;5651.547876169897;5653.378128405872;5655.886882262373;5657.603967722261;5663.405342439026;3858.749181303206;3858.903527411809;3860.208657225262;3863.74885632433;3869.6517313441927;5992.760289588411;6068.484178844804;6074.119252708332;6082.270127584674;6130.448259656652;4046.2716710991717;4106.548279689232;4148.56440073794;4148.854790082332;4152.43942067817;4168.478940132483;4180.874573762792;4208.810603522848;4222.113356195172;4227.87316380509;4803.615710743132;4820.060088282751;4832.637552183601;4841.927371089437;4849.4908034655855;5814.76740930358;5816.73824677882;5817.156512305776;5819;5824.126381042877;1383.3014327764615;1416.6812467194798;1465.1648560320516;1487.68014876802;1488.5013520470764;948.5636607160783;956.4978386347084;961.5672947173799;966.5602151021268;975.078550769516;5027.673201241908;5076.74616269185;5082.847514574569;5085.7202853842655;5088.262201980692;6012.579119461683;6029.909551356734;6041;6042.939570604326;6054.878902421927;5043.36957880265;5050.090983622909;5052.494750524918;5087.949120508748;5094.465081166498;3202.2634793997513;3225.774195806271;3240.4167249895245;3280.114369120324;3310.9503357449657;5703.429657034263;5751.971240143856;5763.596548241583;5780.1907732917425;5793.102069179284;6321.747130114836;6339.461145802658;6345.96827015862;6356.046593010993;6356.427921486996;5656.37779844225;5780.075187969988;5780.942190578125;5785.88428231433;5787.479126878517;6115.602485838406;6135.355787642234;6153.569250152446;6159.599626024294;6163.19878415803;5971.58198926071;5984.970075149597;5986.610870293417;5993.70031498432;6009.609375390585;5726.685032323262;5772.711364431678;5784.305883294031;5784.363719990882;5784.421557844182;3980.144268982183;4059.7361171523758;4064.7357921734992;4066.8169932352525;4076.6534844538546;5928.525717942641;6130.540209484396;6141.109539116893;6141.7543298267565;6151.446369826737;5876.559258055749;5893.233879595625;5928.110783382527;5929.436703513159;5939.109133629817;5907.881842363043;5908.675022873783;5916.31962324321;5923.466887980103;5940.435658612425;5655.971720141373;5753.424657534213;5773.393793651606;5778.624389414675;5780.595358325045;5941.673207973603;5951.137085122719;5952.76188952437;5956.5532585055425;5964.194833697569;5752.7698892043845;5776.162456443876;5794.710264486843;5795.188673585786;5795.536357091507 03:56:20 INFO - PROCESS | 31044 | |5;yui.html;670.4301343857721;742.6323969635032;748.9063867016623;764.5603777827748;810.6919370639156;10994.505247263873;11063.114950803936;11235.101191904649;11255.380954047525;12607.873921260785;12968.546100886471;12996.15524990875;13026.674333141676;13037.804432933513;13136.408861601227;779.9376049915993;780.9180036096199;789.135896193667;798.700487317256;802.8314054048627;798.2576204130156;799.4643588795492;799.6681377228472;803.2931020701774;804.4569915307173;822.9876551851697;830.4436027861348;834.7913021744564;835.9874601880977;836.8493671139192;814.9918500814975;817.2522142239843;820.110180454205;821.7945513621595;822.2065706593106;617.095954426767;617.4905702795212;617.688067525901;617.7065893700501;619.164128426625;11405.315681059163;11420.972112509831;11444.771104577945;11459.083273338112;11495.367754773484;11196.496157672924;11348.773024539463;11406.74525802161;11494.942525287404;11835.644930652008;9296.907030929671;9313.487758173298;9316.580753866092;9547.188488978445;9635.807283854283;3113.579666744983;3132.8721660202536;3156.8579413926427;3163.9209019774457;3178.618565772099;38814.22371552581;39694.20611587781;39713.80143099295;39769.20461590781;39775;8678.86981695275;9242.21441177494;9258;9277.304202184729;9358.812823743623;15540.222988850512;15540.766888496682;15541.45604903823;15583.610409739847;15597.298121584328;6356;6358.33237510064;6457.096006559085;6512.153420055362;6565.376289252514;3545.7872527648424;3557.964420355815;3565.144365352349;3581.391163502211;3607.549056367954;2610.6214598883435;2635.420207554335;2637.3933995181214;2643.947121057568;2651.8541480218773;465.16735044271053;465.2393336894202;474.9572538471554;475.230127193948;478.96886702364236;470.5200695290853;485.48969199584434;586.4926838284938;606.5208485296655;645.9354064593597;7477.1775104738435;7535.472516923763;7563.470557060953;7648.694052237848;7662.310392064741;598.5690302981847;620.1380081686459;630.0832289019465;644.5391545045316;646.9223693156852;3541.6646021821125;3594.8382322795537;3606.3688854450365;3681.4109742441083;3830.751001184914;45456.772716136205;47892.28161577579;50006.74996625067;50033;50775.23837142446;39844.60155398467;39871.2025759489;40035.59964400377;40443.59556404457;41575;38211.42682859759;38384.616153838666;38609.613903861165;38644.61355386466;39013.609863900994;7678.731244406419;8000.959995199987;8010;8034.63844127004;8220.424570280024;29094.563581546718;30143.547846781876;31130;31470.370592587562;33325.50011749777;36730.8163459181;37067.443988339655;37272.06819829526;38419.42370864495;38499.615003849605;10083.092521673085;10145.84781228297;10171.338862973884;10242;10438.373697577867;11027.44402306352;11109.222354435435;11109.277896936674;11133.944330278297;11134.498947547541;10562.630307939493;10595.947020265157;10630.52162652698;10674.73313167177;10692.786144276915;10390.948045259725;10408.167346612405;10427.270091093551;10431.68704938853;10444.529996150344;10083;10371.170306375623;10456.843147352947;10478.842817357594;10538.683839484827;8254.463459875089;8384.287335576544;8426.69386245133;8473;8574.27118694893;8552.572371381282;8884.644614215358;9110.817783644157;9142.588583513625;9434.433933963985 03:56:20 INFO - PROCESS | 31044 | __end_tp_report 03:56:20 INFO - PROCESS | 31044 | __start_cc_report 03:56:20 INFO - PROCESS | 31044 | _x_x_mozilla_cycle_collect,332 03:56:20 INFO - PROCESS | 31044 | __end_cc_report 03:56:20 INFO - PROCESS | 31044 | __startTimestamp1452686180212__endTimestamp 03:56:20 INFO - PROCESS | 31044 | 03:56:20 INFO - PROCESS | 31044 | ------- Summary: start ------- 03:56:20 INFO - PROCESS | 31044 | Number of tests: 6 03:56:20 INFO - PROCESS | 31044 | 03:56:20 INFO - PROCESS | 31044 | [#0] dojo.html Cycles:165 Average:4481.58 Median:4586.84 stddev:458.00 (10.0%) stddev-sans-first:435.88 03:56:20 INFO - PROCESS | 31044 | Values: 2634.3 2643.5 2683.2 2689.4 2703.1 4439.1 4513.9 4531.7 4551.1 4564.5 4448.6 4526.7 4541.1 4578.6 4586.8 4192.8 4219.2 4220.1 4248.4 4265.3 4118.4 4215.5 4233.7 4257.5 4262.7 4036.1 4073.5 4081.9 4114.3 4152.0 4152.0 4162.6 4178.5 4178.7 4188.8 4096.5 4122.5 4132.3 4149.2 4170.6 4305.8 4473.4 4524.2 4524.9 4571.9 4832.1 4842.8 4846.1 4853.6 4860.5 4842.3 4876.2 4886.0 4896.7 4927.6 4465.2 4571.8 4586.2 4600.3 4625.8 4966.4 4978.3 4982.2 4987.0 5045.9 4661.5 4730.2 4780.0 4793.9 4826.5 4873.8 4879.7 4893.0 4919.1 4957.1 4785.5 4791.6 4792.5 4793.0 4808.4 4554.5 4668.6 4685.3 4761.9 4795.8 3963.1 3978.6 3996.9 4012.8 4025.9 3553.7 3561.8 3562.9 3585.7 3602.4 4122.1 4210.6 4223.8 4237.5 4285.4 4878.8 4901.8 4914.6 4919.9 4962.8 4167.0 4224.7 4236.1 4237.0 4277.1 4209.7 4282.9 4325.6 4360.3 4395.0 4545.2 4560.6 4566.1 4582.7 4600.8 4773.5 4812.9 4815.8 4821.6 4881.8 4522.4 4593.4 4634.4 4645.9 4689.9 4781.5 4850.6 4853.8 4863.4 4864.0 4749.7 4858.6 4877.5 4891.3 4970.7 4705.0 4708.3 4720.2 4740.2 4780.4 4731.1 4763.5 4772.0 4772.5 4802.6 4494.6 4541.4 4572.5 4652.6 4656.5 4696.9 4701.0 4715.1 4732.4 4761.8 4567.9 4600.8 4626.6 4659.1 4678.3 03:56:20 INFO - PROCESS | 31044 | 03:56:20 INFO - PROCESS | 31044 | [#1] ext.html Cycles:180 Average:41613.56 Median:3569.47 stddev:71967.91 (2016.2%) stddev-sans-first:72103.52 03:56:20 INFO - PROCESS | 31044 | Values: 475.6 485.8 498.5 504.7 506.4 24264.0 32538.5 32886.3 32948.8 32949.8 36150.3 36689.3 36783.4 37055.3 37061.4 7655.0 7769.3 7819.9 7824.3 7837.6 7535.7 7688.4 7709.9 7715.8 7887.6 7853.2 7938.7 7947.5 7972.1 7979.6 7738.7 7878.5 7879.8 7887.6 7910.9 7671.3 7771.8 7807.3 7813.2 7834.1 36898.8 37046.0 37318.0 37353.3 37432.6 2728.5 2786.2 2864.8 3258.6 3539.9 25700.4 27727.0 27861.0 28265.9 28741.4 3399.6 3500.8 3537.5 3561.1 3577.9 212502.0 212525.0 213054.0 213805.0 214237.0 38704.4 39489.8 39513.4 39557.8 53433.2 36999.4 37035.3 37043.1 37207.1 37211.0 12476.6 12499.8 12601.7 12606.6 12610.6 9524.8 9527.2 9594.7 9644.3 9685.8 13305.2 13440.5 13510.8 13550.0 13587.3 5464.1 5536.0 5592.2 5627.3 5630.4 847.4 872.1 938.5 965.6 979.1 26085.1 26126.5 27480.0 28376.3 28856.1 965.7 970.8 977.3 978.9 1002.9 12090.3 12528.1 12648.1 15204.2 15920.4 336288.0 338213.0 343991.0 344095.0 344954.0 48404.3 49356.5 49381.8 49428.3 49451.5 1210.4 1216.6 1219.1 1219.8 1231.2 27784.7 27980.6 28128.0 28392.1 28432.1 39842.0 40160.6 40264.0 40285.0 40603.4 248986.0 252412.0 252680.0 253365.0 253960.0 28874.4 42204.6 43039.5 43447.6 43581.3 36866.8 37632.0 37918.6 38888.8 38957.2 32160.4 32396.2 32886.3 33090.8 33688.8 32509.5 32652.7 32701.7 32733.5 32739.0 32626.8 33116.0 33298.8 33320.5 33443.0 28411.9 28593.9 29881.0 30970.0 31388.7 22435.4 23272.8 23438.4 23441.8 23525.0 03:56:20 INFO - PROCESS | 31044 | 03:56:20 INFO - PROCESS | 31044 | [#2] jquery.html Cycles:180 Average:26063.91 Median:6153.25 stddev:82112.06 (1334.4%) stddev-sans-first:82319.68 03:56:20 INFO - PROCESS | 31044 | Values: 333.5 333.6 336.1 341.2 341.7 11873.9 12279.5 14133.4 14490.3 14790.7 9471.6 9727.0 9784.2 12577.0 13550.9 4301.8 4487.0 4511.6 4513.8 4517.8 4202.9 6025.4 6343.7 6347.4 6358.0 6156.1 6302.2 6318.9 6404.4 6409.7 6167.0 6382.9 6409.9 6419.0 6419.5 6150.6 6155.9 6160.5 6172.4 6260.8 18441.4 19607.0 20333.7 20455.4 20480.0 1845.2 1873.1 2015.6 2026.9 2053.7 12951.9 13023.7 13184.0 13243.8 13570.2 1839.4 1872.6 1877.1 1884.8 1916.0 53897.0 54681.0 55579.0 55617.0 56102.2 14250.4 14428.4 14454.6 14461.3 14572.1 21608.7 21835.6 21852.3 21869.0 21911.8 7922.3 7929.2 7936.4 7972.1 7973.3 6338.3 6340.6 6372.4 6524.9 6569.7 6191.8 6525.5 7164.8 7188.7 7198.1 2756.3 2840.0 2919.5 2941.7 2968.2 726.0 768.7 782.2 827.8 848.2 13092.6 13242.2 13387.7 13559.4 14413.5 803.5 817.2 842.8 863.9 887.8 8013.5 8135.8 8154.4 8402.5 8767.3 491343.0 494872.0 495582.0 514069.0 519342.0 59534.7 64493.4 65477.7 66544.7 68224.0 1073.8 1097.8 1100.2 1103.8 1106.5 9190.5 12725.6 13694.4 13902.2 14100.7 29737.9 30831.0 30845.2 31968.8 31979.7 39868.0 40123.4 40724.4 41051.4 42266.2 8399.4 8866.4 8890.9 9115.5 9216.4 7160.1 7172.7 7323.0 7480.6 9847.6 6490.0 6597.7 6619.5 6727.7 6827.0 7051.8 7085.4 7179.1 7200.6 7276.6 6720.3 6756.3 6806.3 6813.8 6956.5 9405.2 9464.8 9593.6 9594.4 9678.6 6117.4 6238.7 8927.8 9020.6 9117.6 03:56:20 INFO - PROCESS | 31044 | 03:56:20 INFO - PROCESS | 31044 | [#3] mootools.html Cycles:180 Average:4932.27 Median:6018.99 stddev:2570.05 (42.7%) stddev-sans-first:2561.40 03:56:20 INFO - PROCESS | 31044 | Values: 1135.0 1139.2 1200.4 1513.7 1577.9 6880.8 7031.5 7093.5 7185.6 7195.2 7174.3 7207.5 7285.9 7286.2 7291.3 2148.5 2161.0 2164.1 2174.5 2175.1 2187.7 2211.3 2212.0 2219.2 2221.4 1739.3 1783.5 1978.7 2165.1 2175.8 2159.2 2166.7 2167.9 2175.5 2179.5 2086.5 2105.3 2108.9 2111.5 2116.5 6979.5 7048.4 7088.0 7095.1 7108.8 4016.2 4160.7 4190.4 4191.6 4198.0 2767.3 2770.9 2771.0 2781.8 2804.7 820.3 1733.9 1750.8 1754.2 1755.9 9179.5 9341.4 9345.3 9358.2 9378.7 3924.6 3977.5 3979.7 4034.7 4057.5 7669.9 7671.5 7691.4 7691.9 7706.9 4243.9 4262.4 4265.3 4275.8 4301.1 3884.8 3917.7 3924.4 3930.4 3944.4 3085.3 3122.5 3141.1 3175.3 3180.3 907.8 913.2 914.7 922.1 952.7 723.4 744.9 898.8 959.6 1148.2 6192.9 6402.7 6512.3 6512.9 6519.2 555.6 571.7 572.4 573.5 711.9 5022.7 5083.1 5094.3 5108.2 5131.7 8196.1 9004.1 9068.3 9136.0 9214.9 8850.8 8915.7 8916.4 8920.3 8925.1 6723.2 6734.5 6740.3 6783.4 6841.2 6603.5 6641.7 6668.4 6680.4 6686.6 7705.3 7928.0 7928.2 7993.6 7996.6 8051.7 8241.1 8298.7 8313.5 8332.6 5641.3 5702.1 5704.0 5709.0 5735.1 6276.1 6301.8 6327.2 6339.4 6349.8 6037.3 6041.9 6079.0 6154.7 6173.5 5408.4 5425.4 5928.1 5957.9 6135.7 6245.9 6269.3 6307.6 6313.2 6332.9 5733.4 5912.2 5927.7 5929.2 5939.4 5974.3 5998.3 6013.9 6024.1 6024.2 03:56:20 INFO - PROCESS | 31044 | 03:56:20 INFO - PROCESS | 31044 | [#4] prototype.html Cycles:180 Average:4828.02 Median:5621.98 stddev:1455.85 (25.9%) stddev-sans-first:1419.56 03:56:20 INFO - PROCESS | 31044 | Values: 291.5 304.7 305.3 306.2 306.5 5426.6 5536.7 5543.1 5576.7 5681.3 5565.0 5617.3 5626.7 5640.1 5642.2 4258.8 4263.9 4265.4 4266.4 4272.5 4266.4 4272.7 4275.5 4277.0 4283.4 4062.6 4172.1 4217.4 4221.1 4222.4 4178.4 4196.0 4201.1 4202.1 4206.3 3644.2 3647.0 3652.5 3656.4 3660.1 5325.5 5362.5 5380.2 5383.2 5385.1 4628.9 4634.3 4853.4 4864.9 4886.4 5651.5 5653.4 5655.9 5657.6 5663.4 3858.7 3858.9 3860.2 3863.7 3869.7 5992.8 6068.5 6074.1 6082.3 6130.4 4046.3 4106.5 4148.6 4148.9 4152.4 4168.5 4180.9 4208.8 4222.1 4227.9 4803.6 4820.1 4832.6 4841.9 4849.5 5814.8 5816.7 5817.2 5819.0 5824.1 1383.3 1416.7 1465.2 1487.7 1488.5 948.6 956.5 961.6 966.6 975.1 5027.7 5076.7 5082.8 5085.7 5088.3 6012.6 6029.9 6041.0 6042.9 6054.9 5043.4 5050.1 5052.5 5087.9 5094.5 3202.3 3225.8 3240.4 3280.1 3311.0 5703.4 5752.0 5763.6 5780.2 5793.1 6321.7 6339.5 6346.0 6356.0 6356.4 5656.4 5780.1 5780.9 5785.9 5787.5 6115.6 6135.4 6153.6 6159.6 6163.2 5971.6 5985.0 5986.6 5993.7 6009.6 5726.7 5772.7 5784.3 5784.4 5784.4 3980.1 4059.7 4064.7 4066.8 4076.7 5928.5 6130.5 6141.1 6141.8 6151.4 5876.6 5893.2 5928.1 5929.4 5939.1 5907.9 5908.7 5916.3 5923.5 5940.4 5656.0 5753.4 5773.4 5778.6 5780.6 5941.7 5951.1 5952.8 5956.6 5964.2 5752.8 5776.2 5794.7 5795.2 5795.5 03:56:20 INFO - PROCESS | 31044 | 03:56:20 INFO - PROCESS | 31044 | [#5] yui.html Cycles:180 Average:11915.28 Median:39857.90 stddev:13198.16 (33.1%) stddev-sans-first:13208.16 03:56:20 INFO - PROCESS | 31044 | Values: 670.4 742.6 748.9 764.6 810.7 10994.5 11063.1 11235.1 11255.4 12607.9 12968.5 12996.2 13026.7 13037.8 13136.4 779.9 780.9 789.1 798.7 802.8 798.3 799.5 799.7 803.3 804.5 823.0 830.4 834.8 836.0 836.8 815.0 817.3 820.1 821.8 822.2 617.1 617.5 617.7 617.7 619.2 11405.3 11421.0 11444.8 11459.1 11495.4 11196.5 11348.8 11406.7 11494.9 11835.6 9296.9 9313.5 9316.6 9547.2 9635.8 3113.6 3132.9 3156.9 3163.9 3178.6 38814.2 39694.2 39713.8 39769.2 39775.0 8678.9 9242.2 9258.0 9277.3 9358.8 15540.2 15540.8 15541.5 15583.6 15597.3 6356.0 6358.3 6457.1 6512.2 6565.4 3545.8 3558.0 3565.1 3581.4 3607.5 2610.6 2635.4 2637.4 2643.9 2651.9 465.2 465.2 475.0 475.2 479.0 470.5 485.5 586.5 606.5 645.9 7477.2 7535.5 7563.5 7648.7 7662.3 598.6 620.1 630.1 644.5 646.9 3541.7 3594.8 3606.4 3681.4 3830.8 45456.8 47892.3 50006.7 50033.0 50775.2 39844.6 39871.2 40035.6 40443.6 41575.0 38211.4 38384.6 38609.6 38644.6 39013.6 7678.7 8001.0 8010.0 8034.6 8220.4 29094.6 30143.5 31130.0 31470.4 33325.5 36730.8 37067.4 37272.1 38419.4 38499.6 10083.1 10145.8 10171.3 10242.0 10438.4 11027.4 11109.2 11109.3 11133.9 11134.5 10562.6 10595.9 10630.5 10674.7 10692.8 10390.9 10408.2 10427.3 10431.7 10444.5 10083.0 10371.2 10456.8 10478.8 10538.7 8254.5 8384.3 8426.7 8473.0 8574.3 8552.6 8884.6 9110.8 9142.6 9434.4 03:56:20 INFO - PROCESS | 31044 | -------- Summary: end -------- 03:56:20 INFO - PROCESS | 31044 | 03:56:20 INFO - TEST-INFO | 31044: exit 0 03:56:20 INFO - TEST-OK | dromaeo_css | took 1114332ms 03:56:20 INFO - TEST-START | kraken 03:56:20 INFO - operating with platform_type : linux_ 03:56:20 INFO - Initialising browser for kraken test... 03:56:20 INFO - TEST-INFO | started process 31295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpErkEV6/profile http://localhost:57521/getInfo.html) 03:56:24 INFO - PROCESS | 31295 | 03:56:24 INFO - PROCESS | 31295 | (process:31367): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:56:25 INFO - PROCESS | 31295 | __metrics Screen width/height:1600/1200 03:56:25 INFO - PROCESS | 31295 | colorDepth:24 03:56:25 INFO - PROCESS | 31295 | Browser inner width/height: 1024/697 03:56:25 INFO - PROCESS | 31295 | __metrics 03:56:25 INFO - PROCESS | 31295 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:56:26 INFO - TEST-INFO | 31295: exit 0 03:56:26 INFO - Browser initialized. 03:56:26 INFO - Running cycle 1/1 for kraken test... 03:56:26 INFO - TEST-INFO | started process 31416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpErkEV6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:28 INFO - PROCESS | 31416 | 03:56:28 INFO - PROCESS | 31416 | (process:31474): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:56:38 INFO - PROCESS | 31416 | RSS: Main: 149635072 03:56:38 INFO - PROCESS | 31416 | 03:56:41 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57521/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:41 INFO - PROCESS | 31416 | RSS: Main: 150597632 03:56:41 INFO - PROCESS | 31416 | 03:56:44 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57521/tests/kraken/driver.html?testName=audio-dft) 03:56:45 INFO - PROCESS | 31416 | RSS: Main: 151248896 03:56:45 INFO - PROCESS | 31416 | 03:56:48 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57521/tests/kraken/driver.html?testName=audio-fft) 03:56:48 INFO - PROCESS | 31416 | RSS: Main: 146530304 03:56:48 INFO - PROCESS | 31416 | 03:56:50 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57521/tests/kraken/driver.html?testName=audio-oscillator) 03:56:51 INFO - PROCESS | 31416 | RSS: Main: 146395136 03:56:51 INFO - PROCESS | 31416 | 03:56:53 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:54 INFO - PROCESS | 31416 | RSS: Main: 146325504 03:56:54 INFO - PROCESS | 31416 | 03:56:57 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57521/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:57 INFO - PROCESS | 31416 | RSS: Main: 145854464 03:56:57 INFO - PROCESS | 31416 | 03:57:01 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57521/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:01 INFO - PROCESS | 31416 | RSS: Main: 144900096 03:57:01 INFO - PROCESS | 31416 | 03:57:04 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57521/tests/kraken/driver.html?testName=json-parse-financial) 03:57:05 INFO - PROCESS | 31416 | RSS: Main: 144883712 03:57:05 INFO - PROCESS | 31416 | 03:57:07 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:07 INFO - PROCESS | 31416 | RSS: Main: 147144704 03:57:07 INFO - PROCESS | 31416 | 03:57:09 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57521/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:10 INFO - PROCESS | 31416 | RSS: Main: 147709952 03:57:10 INFO - PROCESS | 31416 | 03:57:12 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:13 INFO - PROCESS | 31416 | RSS: Main: 148365312 03:57:13 INFO - PROCESS | 31416 | 03:57:15 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:16 INFO - PROCESS | 31416 | RSS: Main: 147861504 03:57:16 INFO - PROCESS | 31416 | 03:57:18 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:19 INFO - PROCESS | 31416 | RSS: Main: 147181568 03:57:19 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | Cycle 1(1): loaded http://localhost:57521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57521/tests/kraken/driver.html?testName=ai-astar) 03:57:21 INFO - PROCESS | 31416 | RSS: Main: 147709952 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | __start_tp_report 03:57:21 INFO - PROCESS | 31416 | _x_x_mozilla_page_load 03:57:21 INFO - PROCESS | 31416 | _x_x_mozilla_page_load_details 03:57:21 INFO - PROCESS | 31416 | |i|pagename|runs| 03:57:21 INFO - PROCESS | 31416 | |0;ai-astar;115;108;114;113;115;124;114;113;114;114 03:57:21 INFO - PROCESS | 31416 | |1;audio-beat-detection;161;137;156;180;134;150;165;140;168;132 03:57:21 INFO - PROCESS | 31416 | |2;audio-dft;163;163;165;162;163;163;173;163;164;161 03:57:21 INFO - PROCESS | 31416 | |3;audio-fft;76;73;73;72;148;73;74;76;72;147 03:57:21 INFO - PROCESS | 31416 | |4;audio-oscillator;96;97;143;97;96;97;139;97;98;136 03:57:21 INFO - PROCESS | 31416 | |5;imaging-gaussian-blur;110;111;110;110;109;110;109;109;110;110 03:57:21 INFO - PROCESS | 31416 | |6;imaging-darkroom;149;150;148;148;147;149;147;148;148;151 03:57:21 INFO - PROCESS | 31416 | |7;imaging-desaturate;95;96;96;97;96;97;96;98;97;96 03:57:21 INFO - PROCESS | 31416 | |8;json-parse-financial;69;69;70;70;70;69;70;69;70;69 03:57:21 INFO - PROCESS | 31416 | |9;json-stringify-tinderbox;67;67;73;67;71;68;68;68;67;68 03:57:21 INFO - PROCESS | 31416 | |10;stanford-crypto-aes;91;85;91;82;83;85;85;94;97;96 03:57:21 INFO - PROCESS | 31416 | |11;stanford-crypto-ccm;131;131;120;118;118;135;122;126;122;126 03:57:21 INFO - PROCESS | 31416 | |12;stanford-crypto-pbkdf2;150;151;152;159;149;149;145;148;148;158 03:57:21 INFO - PROCESS | 31416 | |13;stanford-crypto-sha256-iterative;69;69;72;69;72;70;71;72;69;72 03:57:21 INFO - PROCESS | 31416 | __end_tp_report 03:57:21 INFO - PROCESS | 31416 | __start_cc_report 03:57:21 INFO - PROCESS | 31416 | _x_x_mozilla_cycle_collect,794 03:57:21 INFO - PROCESS | 31416 | __end_cc_report 03:57:21 INFO - PROCESS | 31416 | __startTimestamp1452686241571__endTimestamp 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | ------- Summary: start ------- 03:57:21 INFO - PROCESS | 31416 | Number of tests: 14 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:3.92 (3.4%) stddev-sans-first:4.15 03:57:21 INFO - PROCESS | 31416 | Values: 115.0 108.0 114.0 113.0 115.0 124.0 114.0 113.0 114.0 114.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:158.50 stddev:16.34 (10.3%) stddev-sans-first:17.02 03:57:21 INFO - PROCESS | 31416 | Values: 161.0 137.0 156.0 180.0 134.0 150.0 165.0 140.0 168.0 132.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.33 (2.0%) stddev-sans-first:3.52 03:57:21 INFO - PROCESS | 31416 | Values: 163.0 163.0 165.0 162.0 163.0 163.0 173.0 163.0 164.0 161.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#3] audio-fft Cycles:10 Average:88.40 Median:73.00 stddev:31.18 (42.7%) stddev-sans-first:32.75 03:57:21 INFO - PROCESS | 31416 | Values: 76.0 73.0 73.0 72.0 148.0 73.0 74.0 76.0 72.0 147.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:97.00 stddev:20.59 (21.2%) stddev-sans-first:21.25 03:57:21 INFO - PROCESS | 31416 | Values: 96.0 97.0 143.0 97.0 96.0 97.0 139.0 97.0 98.0 136.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 03:57:21 INFO - PROCESS | 31416 | Values: 110.0 111.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.27 (0.9%) stddev-sans-first:1.33 03:57:21 INFO - PROCESS | 31416 | Values: 149.0 150.0 148.0 148.0 147.0 149.0 147.0 148.0 148.0 151.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.73 03:57:21 INFO - PROCESS | 31416 | Values: 95.0 96.0 96.0 97.0 96.0 97.0 96.0 98.0 97.0 96.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#8] json-parse-financial Cycles:10 Average:69.50 Median:70.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 03:57:21 INFO - PROCESS | 31416 | Values: 69.0 69.0 70.0 70.0 70.0 69.0 70.0 69.0 70.0 69.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:2.01 (3.0%) stddev-sans-first:2.07 03:57:21 INFO - PROCESS | 31416 | Values: 67.0 67.0 73.0 67.0 71.0 68.0 68.0 68.0 67.0 68.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:91.00 stddev:5.57 (6.1%) stddev-sans-first:5.85 03:57:21 INFO - PROCESS | 31416 | Values: 91.0 85.0 91.0 82.0 83.0 85.0 85.0 94.0 97.0 96.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:5.92 (4.7%) stddev-sans-first:5.85 03:57:21 INFO - PROCESS | 31416 | Values: 131.0 131.0 120.0 118.0 118.0 135.0 122.0 126.0 122.0 126.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:150.50 stddev:4.43 (2.9%) stddev-sans-first:4.69 03:57:21 INFO - PROCESS | 31416 | Values: 150.0 151.0 152.0 159.0 149.0 149.0 145.0 148.0 148.0 158.0 03:57:21 INFO - PROCESS | 31416 | 03:57:21 INFO - PROCESS | 31416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.50 stddev:1.43 (2.0%) stddev-sans-first:1.41 03:57:21 INFO - PROCESS | 31416 | Values: 69.0 69.0 72.0 69.0 72.0 70.0 71.0 72.0 69.0 72.0 03:57:21 INFO - PROCESS | 31416 | -------- Summary: end -------- 03:57:21 INFO - PROCESS | 31416 | 03:57:22 INFO - TEST-INFO | 31416: exit 0 03:57:22 INFO - TEST-OK | kraken | took 61642ms 03:57:22 INFO - TEST-START | v8_7 03:57:22 INFO - operating with platform_type : linux_ 03:57:22 INFO - Initialising browser for v8_7 test... 03:57:22 INFO - TEST-INFO | started process 31703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyidkxD/profile http://localhost:57521/getInfo.html) 03:57:26 INFO - PROCESS | 31703 | 03:57:26 INFO - PROCESS | 31703 | (process:31773): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:57:27 INFO - PROCESS | 31703 | __metrics Screen width/height:1600/1200 03:57:27 INFO - PROCESS | 31703 | colorDepth:24 03:57:27 INFO - PROCESS | 31703 | Browser inner width/height: 1024/697 03:57:27 INFO - PROCESS | 31703 | __metrics 03:57:27 INFO - PROCESS | 31703 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:57:28 INFO - TEST-INFO | 31703: exit 0 03:57:28 INFO - Browser initialized. 03:57:28 INFO - Running cycle 1/1 for v8_7 test... 03:57:28 INFO - TEST-INFO | started process 31822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyidkxD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:29 INFO - PROCESS | 31822 | 03:57:29 INFO - PROCESS | 31822 | (process:31880): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:57:40 INFO - PROCESS | 31822 | RSS: Main: 149803008 03:57:40 INFO - PROCESS | 31822 | 03:58:02 INFO - PROCESS | 31822 | Cycle 1(1): loaded http://localhost:57521/tests/v8_7/run.html (next: http://localhost:57521/tests/v8_7/run.html) 03:58:03 INFO - PROCESS | 31822 | RSS: Main: 145281024 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | __start_tp_report 03:58:03 INFO - PROCESS | 31822 | _x_x_mozilla_page_load 03:58:03 INFO - PROCESS | 31822 | _x_x_mozilla_page_load_details 03:58:03 INFO - PROCESS | 31822 | |i|pagename|runs| 03:58:03 INFO - PROCESS | 31822 | |0;Richards;167.53224995811695 03:58:03 INFO - PROCESS | 31822 | |1;DeltaBlue;187.93459875963165 03:58:03 INFO - PROCESS | 31822 | |2;Encrypt;280.19052956010086 03:58:03 INFO - PROCESS | 31822 | |3;Decrypt;5273.684210526316 03:58:03 INFO - PROCESS | 31822 | |4;RayTrace;1117.31843575419 03:58:03 INFO - PROCESS | 31822 | |5;Earley;701.7543859649123 03:58:03 INFO - PROCESS | 31822 | |6;Boyer;12280.487804878048 03:58:03 INFO - PROCESS | 31822 | |7;RegExp;43085.10638297872 03:58:03 INFO - PROCESS | 31822 | |8;Splay;608.272506082725 03:58:03 INFO - PROCESS | 31822 | |9;NavierStokes;4840.579710144928 03:58:03 INFO - PROCESS | 31822 | __end_tp_report 03:58:03 INFO - PROCESS | 31822 | __startTimestamp1452686283154__endTimestamp 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | ------- Summary: start ------- 03:58:03 INFO - PROCESS | 31822 | Number of tests: 10 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 167.5 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#1] DeltaBlue Cycles:1 Average:187.93 Median:187.93 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 187.9 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 280.2 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 5273.7 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#4] RayTrace Cycles:1 Average:1117.32 Median:1117.32 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 1117.3 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#5] Earley Cycles:1 Average:701.75 Median:701.75 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 701.8 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 12280.5 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#7] RegExp Cycles:1 Average:43085.11 Median:43085.11 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 43085.1 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#8] Splay Cycles:1 Average:608.27 Median:608.27 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 608.3 03:58:03 INFO - PROCESS | 31822 | 03:58:03 INFO - PROCESS | 31822 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 03:58:03 INFO - PROCESS | 31822 | Values: 4840.6 03:58:03 INFO - PROCESS | 31822 | -------- Summary: end -------- 03:58:03 INFO - PROCESS | 31822 | 03:58:04 INFO - TEST-INFO | 31822: exit 0 03:58:04 INFO - TEST-OK | v8_7 | took 41463ms 03:58:04 INFO - SUITE-END | took 1217s 03:58:04 INFO - Completed test suite (00:20:17) 03:58:04 INFO - Working with test: dromaeo_css 03:58:04 INFO - Generating results file: dromaeo_css 03:58:04 INFO - Working with test: kraken 03:58:04 INFO - Generating results file: kraken 03:58:04 INFO - javascript benchmark 03:58:04 INFO - Working with test: v8_7 03:58:04 INFO - Generating results file: v8_7 03:58:04 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:58:04 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:58:04 INFO - process_Request line: dromaeo_css 6219.53 graph.html#tests=[[72,132,43]] 03:58:04 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:58:04 INFO - process_Request line: kraken 1556.50 graph.html#tests=[[232,132,43]] 03:58:04 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:58:04 INFO - process_Request line: v8_7 20171.01 graph.html#tests=[[230,132,43]] 03:58:04 INFO - RETURN: dromaeo_css: 6219.53 03:58:04 INFO - RETURN: kraken: 1556.50 03:58:04 INFO - RETURN: v8_7: 20171.01 03:58:04 INFO - javascript benchmark 03:58:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.2755742170903, 2643.4845205184997, 2683.18162960297, 2689.394886150615, 2703.148508219911, 4439.134368798085, 4513.887152821177, 4531.7054391464535, 4551.089782043597, 4564.543545645433, 4448.644108471322, 4526.70576412533, 4541.069080838429, 4578.587927086562, 4586.8394606188795, 4192.769397683126, 4219.2405367033925, 4220.07158425146, 4248.362745588156, 4265.296226122686, 4118.38224266361, 4215.45199124115, 4233.6824738144605, 4257.467816522934, 4262.72292301001, 4036.0717035082093, 4073.489977960982, 4081.9183616327805, 4114.300568903263, 4151.9999999999845, 4152.0, 4162.646175075122, 4178.456800615931, 4178.7283826551175, 4188.81150348235, 4096.487939007624, 4122.464079669654, 4132.33882578789, 4149.232392007458, 4170.582941705836, 4305.84929527465, 4473.396091527635, 4524.23088075028, 4524.909501809978, 4571.862844114648, 4832.106060378841, 4842.782074806642, 4846.0550192712435, 4853.635977301717, 4860.465348811628, 4842.2736589511505, 4876.171050921352, 4885.951140488585, 4896.681715688469, 4927.556519913189, 4465.173942820588, 4571.839985600522, 4586.197415452282, 4600.2869555218995, 4625.7687115644085, 4966.354373931438, 4978.30303757467, 4982.153033984159, 4986.975065124724, 5045.8738531537, 4661.463931647836, 4730.172219861511, 4780.043991201774, 4793.904121917542, 4826.469088400273, 4873.756312184448, 4879.707217566957, 4892.975535122301, 4919.065377578248, 4957.082939656175, 4785.521447855256, 4791.616670666338, 4792.544708252711, 4793.041391721669, 4808.374911261583, 4554.521775213621, 4668.626509879202, 4685.250359942393, 4761.857144285677, 4795.808167673324, 3963.128111815396, 3978.6021397860563, 3996.86010989614, 4012.8194231259663, 4025.939610905839, 3553.662402071799, 3561.8041007744305, 3562.856844710139, 3585.6952159066773, 3602.369585322558, 4122.093139509303, 4210.59999300066, 4223.809928553223, 4237.512686041083, 4285.442892424027, 4878.82924097662, 4901.779419926112, 4914.606831453475, 4919.90160196794, 4962.826301079445, 4166.979090122939, 4224.725392849455, 4236.110416812442, 4236.961944323661, 4277.080427708058, 4209.7474151551005, 4282.850100246476, 4325.6106950374615, 4360.324149756792, 4395.03309271966, 4545.159145558082, 4560.6123479503285, 4566.132434837436, 4582.679212455229, 4600.7929643166135, 4773.474917758975, 4812.903741925212, 4815.807367705253, 4821.614270858393, 4881.780319885543, 4522.412086428743, 4593.425821772278, 4634.37435946143, 4645.860624181145, 4689.882752931204, 4781.521847815191, 4850.563449289581, 4853.781579828846, 4863.440704318907, 4863.975680121577, 4749.715017098847, 4858.562729354375, 4877.5366340197625, 4891.31521586971, 4970.652054356305, 4704.976475117603, 4708.270218116198, 4720.150372932768, 4740.170470167638, 4780.354652121919, 4731.124741922756, 4763.476017638126, 4771.976140119277, 4772.49888761675, 4802.615790736802, 4494.617957473521, 4541.364209010675, 4572.474165471013, 4652.581267685924, 4656.534346565317, 4696.882577935579, 4701.0362875609735, 4715.104130215248, 4732.384789977281, 4761.833335833229, 4567.885802854955, 4600.769961501978, 4626.583607475343, 4659.138059459011, 4678.298255261738], "unit": "score", "name": "dojo.html", "value": 4453.991502234881}, {"lowerIsBetter": false, "replicates": [475.6242568370987, 485.81053389178203, 498.47908935162764, 504.669441515807, 506.4302659508052, 24264.0, 32538.511922321184, 32886.34227315452, 32948.835255823746, 32949.83525082377, 36150.27699446016, 36689.26621467569, 36783.4482482763, 37055.25889482215, 37061.44407833885, 7654.9617251913805, 7769.339606133485, 7819.9218007820045, 7824.334931530827, 7837.568933708644, 7535.698572057111, 7688.423368247376, 7709.922900770976, 7715.845683086335, 7887.645055972466, 7853.214678532158, 7938.682452701885, 7947.4834135781275, 7972.123066462685, 7979.56112413817, 7738.651760670783, 7878.527288362688, 7879.803004924894, 7887.605619718991, 7910.920890791076, 7671.2712292332135, 7771.766846994599, 7807.258310460554, 7813.218678132142, 7834.059912810442, 36898.81550592257, 37046.0, 37318.0, 37353.25293494115, 37432.62567374318, 2728.5088684036864, 2786.178077467152, 2864.799464037518, 3258.6089669239605, 3539.911502212465, 25700.357491062874, 27727.0, 27861.0, 28265.85867070672, 28741.425171496452, 3399.5750531183603, 3500.789952602852, 3537.4693795930557, 3561.056320075182, 3577.874774382884, 212502.0, 212525.0, 213054.0, 213804.99999999846, 214237.0, 38704.419433708514, 39489.802550987064, 39513.40729889054, 39557.80221098876, 53433.198502022504, 36999.445008324896, 37035.25929481395, 37043.07392315214, 37207.069823254635, 37211.0, 12476.563320283747, 12499.812502812465, 12601.747965040831, 12606.621801345975, 12610.621681349574, 9524.761880952892, 9527.237820974306, 9594.66418675343, 9644.276679249084, 9685.757856053655, 13305.201687898758, 13440.529581464602, 13510.797338039938, 13550.0, 13587.252701101534, 5464.0711079116645, 5535.972320138454, 5592.189132575753, 5627.324721033502, 5630.40880707528, 847.3771777743353, 872.0843114729508, 938.5260443476001, 965.6234068713208, 979.0522575354748, 26085.08702195414, 26126.477470450485, 27480.0, 28376.290592735346, 28856.134315970554, 965.710286913923, 970.8252514547308, 977.3158788847835, 978.9265805064506, 1002.8946960569035, 12090.274583525017, 12528.060395470377, 12648.051396145325, 15204.16377099248, 15920.442784502487, 336288.0, 338213.0, 343991.0, 344095.0, 344954.0, 48404.27393589028, 49356.50643493519, 49381.753091235034, 49428.258576121385, 49451.50548494541, 1210.425048102162, 1216.5985224875947, 1219.1222319929636, 1219.7560487902456, 1231.150506150771, 27784.722152778213, 27980.580291296053, 28128.0, 28392.148235552966, 28432.14703558814, 39842.0, 40160.59839401569, 40264.0, 40285.0, 40603.390949135195, 248986.0, 252412.0, 252680.0, 253365.0, 253960.0, 28874.42251155007, 42204.57795422006, 43039.4500896598, 43447.56552434561, 43581.34627980519, 36866.8156659215, 37632.0, 37918.620813792615, 38888.80555597204, 38957.22085558216, 32160.356792863542, 32396.190095247806, 32886.34227315488, 33090.834545827114, 33688.831555842065, 32509.512357315132, 32652.673473264964, 32701.672983270815, 32733.508997365534, 32739.0, 32626.83686581552, 33116.0, 33298.83350583328, 33320.50019249762, 33443.0, 28411.857940710164, 28593.857030715546, 29881.0, 30970.0, 31388.68611313949, 22435.43911402163, 23272.76727232706, 23438.414039649146, 23441.76558234396, 23525.0], "unit": "score", "name": "ext.html", "value": 16271.33333511368}, {"lowerIsBetter": false, "replicates": [333.4647890136331, 333.6096766782865, 336.0942260607662, 341.16925286926323, 341.67711512620576, 11873.940630296858, 12279.508819647226, 14133.363998620061, 14490.347934342954, 14790.70418591629, 9471.573779179937, 9727.0, 9784.168345690625, 12577.0, 13550.864491355083, 4301.827926882929, 4487.035287413206, 4511.6165125964335, 4513.7517436540975, 4517.819287228507, 4202.852900148496, 6025.367336429677, 6343.746250149989, 6347.365263473639, 6358.0, 6156.076588511714, 6302.212223472066, 6318.936810631881, 6404.42360187583, 6409.679516024204, 6167.0, 6382.904256436134, 6409.8718025639455, 6419.005054216604, 6419.518536109764, 6150.569460137747, 6155.938440615581, 6160.507159427235, 6172.351903050205, 6260.843478913018, 18441.35455259073, 19607.0, 20333.694994575093, 20455.386338409873, 20480.0, 1845.1604519943528, 1873.1383563560642, 2015.6371853066441, 2026.9493262668404, 2053.7330147080784, 12951.87048129516, 13023.674408139777, 13184.0, 13243.801342979863, 13570.185788852701, 1839.3838064248494, 1872.5599484121221, 1877.11775465531, 1884.8271415108459, 1915.9712604310946, 53897.0, 54681.0, 55579.0, 55617.0, 56102.15846762343, 14250.429982800571, 14428.42286308536, 14454.566363009126, 14461.27693615315, 14572.125672459686, 21608.675869861963, 21835.58068725528, 21852.344429667137, 21869.0, 21911.780882190975, 7922.286994170437, 7929.246721561442, 7936.365090792723, 7972.083210430875, 7973.282404583615, 6338.30278669346, 6340.619562826245, 6372.426481616584, 6524.902126468107, 6569.737210511622, 6191.752329906843, 6525.543211975116, 7164.7850564482105, 7188.676509557083, 7198.100237470317, 2756.2558109310376, 2840.0, 2919.474494590994, 2941.7205365490245, 2968.168912704446, 725.9854802903913, 768.7309441695473, 782.1865260129515, 827.7930517370658, 848.2196379331031, 13092.607221783363, 13242.205467671778, 13387.732245355039, 13559.389827457788, 14413.49552765669, 803.4737247103157, 817.1909809288761, 842.7598134531629, 863.8661007543841, 887.7691800132012, 8013.519188848688, 8135.75592732219, 8154.429189956765, 8402.453840500348, 8767.342449316198, 491343.0, 494872.0, 495582.0, 514069.0, 519342.0, 59534.70232648809, 64493.35506644967, 65477.67261163663, 66544.66727666427, 68224.0, 1073.7798751255973, 1097.8188598881095, 1100.2188446203124, 1103.8289065194908, 1106.5186643809968, 9190.54047297619, 12725.61823145307, 13694.383752730952, 13902.23537705436, 14100.717985640435, 29737.851310743306, 30831.0, 30845.228869278446, 31968.840155799073, 31979.68020319767, 39868.0, 40123.398149027205, 40724.389134163604, 41051.38422923599, 42266.15467690567, 8399.412041157304, 8866.379353445196, 8890.866637000321, 9115.498647574183, 9216.447013178962, 7160.140783106061, 7172.677229524579, 7323.0, 7480.551166930001, 9847.556859941464, 6490.0, 6597.736090556324, 6619.536632435684, 6727.697253623501, 6827.0, 7051.753188638373, 7085.433165346657, 7179.066721326194, 7200.639968001474, 7276.636168191675, 6720.32796720324, 6756.256811750802, 6806.285340039224, 6813.829654258683, 6956.513044087068, 9405.24758019343, 9464.810703786023, 9593.568289426852, 9594.376365536218, 9678.612855485984, 6117.388261173847, 6238.6880655967925, 8927.821443570961, 9020.639174432948, 9117.635294588143], "unit": "score", "name": "jquery.html", "value": 8050.57273925931}, {"lowerIsBetter": false, "replicates": [1134.9829752553708, 1139.213942379758, 1200.4297958469729, 1513.6594266290085, 1577.8501042400967, 6880.759173428931, 7031.507794454384, 7093.503454758169, 7185.6047917364585, 7195.244499327574, 7174.282571742823, 7207.49547531673, 7285.890711639317, 7286.234945330743, 7291.343779059884, 2148.4736239621275, 2161.027537608075, 2164.1127137873477, 2174.521605246843, 2175.1082056356895, 2187.69372287879, 2211.281333566589, 2211.9557608847813, 2219.1789038055863, 2221.3669104305277, 1739.3216645508262, 1783.5451959750246, 1978.6834106542956, 2165.1231251343233, 2175.760666326703, 2159.222679835258, 2166.7399912010583, 2167.8916054197225, 2175.5322605639703, 2179.5096103376773, 2086.467950672584, 2105.3157723739846, 2108.8734675919495, 2111.5249068959515, 2116.502621883856, 6979.511434199608, 7048.436125109979, 7087.964560177218, 7095.148582170121, 7108.822279443004, 4016.2168377166463, 4160.687948403852, 4190.371444283352, 4191.601797829232, 4197.958020419787, 2767.266674331304, 2770.9445811083665, 2770.9584356234473, 2781.8330900146057, 2804.6634403871462, 820.2699597358355, 1733.9219735111951, 1750.8249175082517, 1754.1938374234708, 1755.920983555743, 9179.541022948826, 9341.392809467363, 9345.252379809666, 9358.204552612968, 9378.718638440858, 3924.6271604197555, 3977.5226972763453, 3979.7413168143976, 4034.7290603459815, 4057.5130984282073, 7669.884951725729, 7671.501352412075, 7691.384689224848, 7691.884621730678, 7706.884396734054, 4243.893902652459, 4262.360645903139, 4265.338872474771, 4275.764832934156, 4301.0537681709975, 3884.8057597120596, 3917.6865850731874, 3924.3524818405212, 3930.3514920038447, 3944.4083387492105, 3085.3212293295437, 3122.484790009623, 3141.1361875484426, 3175.3173067790535, 3180.3480286541203, 907.832051070554, 913.2283220678516, 914.6752902719572, 922.1285884838898, 952.6713283917038, 723.4176487927269, 744.9180590135081, 898.8067565473455, 959.5633986536109, 1148.2192109365544, 6192.907106393408, 6402.711877965409, 6512.283648798629, 6512.934870651327, 6519.152510173647, 555.5777609017176, 571.6998575747766, 572.3589579670712, 573.4781348972415, 711.8574687626389, 5022.698638081727, 5083.110455670243, 5094.337736094358, 5108.208227724708, 5131.7434128293435, 8196.139405362352, 9004.054574269738, 9068.274538036942, 9136.0, 9214.90785092154, 8850.822983540293, 8915.73252802417, 8916.37585369031, 8920.286377089817, 8925.062868398725, 6723.22682891464, 6734.494912881455, 6740.29226931175, 6783.38949494538, 6841.24746277919, 6603.537752357289, 6641.734330626721, 6668.399844013868, 6680.3987641112535, 6686.632235227109, 7705.345045671181, 7927.960360198162, 7928.207179282025, 7993.560354180576, 7996.60016999136, 8051.718189863327, 8241.134680858424, 8298.668053277801, 8313.542755148525, 8332.583370831555, 5641.26663533738, 5702.059160238514, 5704.0, 5709.029464991045, 5735.13972904051, 6276.1213430118905, 6301.8109456716375, 6327.209098862642, 6339.397757213057, 6349.77775777864, 6037.275526936795, 6041.9395806041375, 6079.0, 6154.692265386623, 6173.536984726254, 5408.3509978802795, 5425.376081750492, 5928.081147422156, 5957.940420595739, 6135.693215339126, 6245.9063114052415, 6269.310375858743, 6307.558470906993, 6313.210848643919, 6332.936670633235, 5733.369329373682, 5912.172295878494, 5927.7036148191555, 5929.229200204119, 5939.406059394026, 5974.312954010345, 5998.280206375263, 6013.909791353046, 6024.0662697282, 6024.216851809412], "unit": "score", "name": "mootools.html", "value": 4025.1083289296726}, {"lowerIsBetter": false, "replicates": [291.50298740647196, 304.6709553682024, 305.3191383215428, 306.22525011720353, 306.4988743404534, 5426.62013659044, 5536.667799932002, 5543.143047079223, 5576.6932818695, 5681.346645135811, 5564.972175139129, 5617.269754931853, 5626.690532020737, 5640.097584386499, 5642.210090587311, 4258.765767882765, 4263.87208383749, 4265.381519679645, 4266.424032755569, 4272.530021697627, 4266.445362102922, 4272.679549033819, 4275.5296917339065, 4276.957230427687, 4283.4431523902, 4062.6343629073376, 4172.102997855461, 4217.367394890775, 4221.05026369066, 4222.366645003259, 4178.435911151986, 4195.951012246938, 4201.096764195682, 4202.054537729002, 4206.348016057485, 3644.180059486621, 3647.0, 3652.506911566931, 3656.433252845813, 3660.084978755311, 5325.467453254682, 5362.4637536246455, 5380.21986811914, 5383.192521121824, 5385.111456609655, 4628.861134165981, 4634.281686338623, 4853.39332583427, 4864.902701945976, 4886.389201349832, 5651.547876169897, 5653.378128405872, 5655.886882262373, 5657.603967722261, 5663.405342439026, 3858.749181303206, 3858.903527411809, 3860.208657225262, 3863.74885632433, 3869.6517313441927, 5992.760289588411, 6068.484178844804, 6074.119252708332, 6082.270127584674, 6130.448259656652, 4046.2716710991717, 4106.548279689232, 4148.56440073794, 4148.854790082332, 4152.43942067817, 4168.478940132483, 4180.874573762792, 4208.810603522848, 4222.113356195172, 4227.87316380509, 4803.615710743132, 4820.060088282751, 4832.637552183601, 4841.927371089437, 4849.4908034655855, 5814.76740930358, 5816.73824677882, 5817.156512305776, 5819.0, 5824.126381042877, 1383.3014327764615, 1416.6812467194798, 1465.1648560320516, 1487.68014876802, 1488.5013520470764, 948.5636607160783, 956.4978386347084, 961.5672947173799, 966.5602151021268, 975.078550769516, 5027.673201241908, 5076.74616269185, 5082.847514574569, 5085.7202853842655, 5088.262201980692, 6012.579119461683, 6029.909551356734, 6041.0, 6042.939570604326, 6054.878902421927, 5043.36957880265, 5050.090983622909, 5052.494750524918, 5087.949120508748, 5094.465081166498, 3202.2634793997513, 3225.774195806271, 3240.4167249895245, 3280.114369120324, 3310.9503357449657, 5703.429657034263, 5751.971240143856, 5763.596548241583, 5780.1907732917425, 5793.102069179284, 6321.747130114836, 6339.461145802658, 6345.96827015862, 6356.046593010993, 6356.427921486996, 5656.37779844225, 5780.075187969988, 5780.942190578125, 5785.88428231433, 5787.479126878517, 6115.602485838406, 6135.355787642234, 6153.569250152446, 6159.599626024294, 6163.19878415803, 5971.58198926071, 5984.970075149597, 5986.610870293417, 5993.70031498432, 6009.609375390585, 5726.685032323262, 5772.711364431678, 5784.305883294031, 5784.363719990882, 5784.421557844182, 3980.144268982183, 4059.7361171523758, 4064.7357921734992, 4066.8169932352525, 4076.6534844538546, 5928.525717942641, 6130.540209484396, 6141.109539116893, 6141.7543298267565, 6151.446369826737, 5876.559258055749, 5893.233879595625, 5928.110783382527, 5929.436703513159, 5939.109133629817, 5907.881842363043, 5908.675022873783, 5916.31962324321, 5923.466887980103, 5940.435658612425, 5655.971720141373, 5753.424657534213, 5773.393793651606, 5778.624389414675, 5780.595358325045, 5941.673207973603, 5951.137085122719, 5952.76188952437, 5956.5532585055425, 5964.194833697569, 5752.7698892043845, 5776.162456443876, 5794.710264486843, 5795.188673585786, 5795.536357091507], "unit": "score", "name": "prototype.html", "value": 4351.869563632462}, {"lowerIsBetter": false, "replicates": [670.4301343857721, 742.6323969635032, 748.9063867016623, 764.5603777827748, 810.6919370639156, 10994.505247263873, 11063.114950803936, 11235.101191904649, 11255.380954047525, 12607.873921260785, 12968.546100886471, 12996.15524990875, 13026.674333141676, 13037.804432933513, 13136.408861601227, 779.9376049915993, 780.9180036096199, 789.135896193667, 798.700487317256, 802.8314054048627, 798.2576204130156, 799.4643588795492, 799.6681377228472, 803.2931020701774, 804.4569915307173, 822.9876551851697, 830.4436027861348, 834.7913021744564, 835.9874601880977, 836.8493671139192, 814.9918500814975, 817.2522142239843, 820.110180454205, 821.7945513621595, 822.2065706593106, 617.095954426767, 617.4905702795212, 617.688067525901, 617.7065893700501, 619.164128426625, 11405.315681059163, 11420.972112509831, 11444.771104577945, 11459.083273338112, 11495.367754773484, 11196.496157672924, 11348.773024539463, 11406.74525802161, 11494.942525287404, 11835.644930652008, 9296.907030929671, 9313.487758173298, 9316.580753866092, 9547.188488978445, 9635.807283854283, 3113.579666744983, 3132.8721660202536, 3156.8579413926427, 3163.9209019774457, 3178.618565772099, 38814.22371552581, 39694.20611587781, 39713.80143099295, 39769.20461590781, 39775.0, 8678.86981695275, 9242.21441177494, 9258.0, 9277.304202184729, 9358.812823743623, 15540.222988850512, 15540.766888496682, 15541.45604903823, 15583.610409739847, 15597.298121584328, 6356.0, 6358.33237510064, 6457.096006559085, 6512.153420055362, 6565.376289252514, 3545.7872527648424, 3557.964420355815, 3565.144365352349, 3581.391163502211, 3607.549056367954, 2610.6214598883435, 2635.420207554335, 2637.3933995181214, 2643.947121057568, 2651.8541480218773, 465.16735044271053, 465.2393336894202, 474.9572538471554, 475.230127193948, 478.96886702364236, 470.5200695290853, 485.48969199584434, 586.4926838284938, 606.5208485296655, 645.9354064593597, 7477.1775104738435, 7535.472516923763, 7563.470557060953, 7648.694052237848, 7662.310392064741, 598.5690302981847, 620.1380081686459, 630.0832289019465, 644.5391545045316, 646.9223693156852, 3541.6646021821125, 3594.8382322795537, 3606.3688854450365, 3681.4109742441083, 3830.751001184914, 45456.772716136205, 47892.28161577579, 50006.74996625067, 50033.0, 50775.23837142446, 39844.60155398467, 39871.2025759489, 40035.59964400377, 40443.59556404457, 41575.0, 38211.42682859759, 38384.616153838666, 38609.613903861165, 38644.61355386466, 39013.609863900994, 7678.731244406419, 8000.959995199987, 8010.0, 8034.63844127004, 8220.424570280024, 29094.563581546718, 30143.547846781876, 31130.0, 31470.370592587562, 33325.50011749777, 36730.8163459181, 37067.443988339655, 37272.06819829526, 38419.42370864495, 38499.615003849605, 10083.092521673085, 10145.84781228297, 10171.338862973884, 10242.0, 10438.373697577867, 11027.44402306352, 11109.222354435435, 11109.277896936674, 11133.944330278297, 11134.498947547541, 10562.630307939493, 10595.947020265157, 10630.52162652698, 10674.73313167177, 10692.786144276915, 10390.948045259725, 10408.167346612405, 10427.270091093551, 10431.68704938853, 10444.529996150344, 10083.0, 10371.170306375623, 10456.843147352947, 10478.842817357594, 10538.683839484827, 8254.463459875089, 8384.287335576544, 8426.69386245133, 8473.0, 8574.27118694893, 8552.572371381282, 8884.644614215358, 9110.817783644157, 9142.588583513625, 9434.433933963985], "unit": "score", "name": "yui.html", "value": 5663.032951619136}], "name": "dromaeo_css", "value": 6219.529952718562}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 114.0, 113.0, 115.0, 124.0, 114.0, 113.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [161.0, 137.0, 156.0, 180.0, 134.0, 150.0, 165.0, 140.0, 168.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 165.0, 162.0, 163.0, 163.0, 173.0, 163.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 73.0, 72.0, 148.0, 73.0, 74.0, 76.0, 72.0, 147.0], "unit": "score", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 143.0, 97.0, 96.0, 97.0, 139.0, 97.0, 98.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 148.0, 148.0, 147.0, 149.0, 147.0, 148.0, 148.0, 151.0], "unit": "score", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 98.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 70.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 69.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 73.0, 67.0, 71.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [91.0, 85.0, 91.0, 82.0, 83.0, 85.0, 85.0, 94.0, 97.0, 96.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [131.0, 131.0, 120.0, 118.0, 118.0, 135.0, 122.0, 126.0, 122.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [150.0, 151.0, 152.0, 159.0, 149.0, 149.0, 145.0, 148.0, 148.0, 158.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 72.0, 69.0, 72.0, 70.0, 71.0, 72.0, 69.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1556.5000000000005}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [187.93459875963165], "unit": "score", "name": "DeltaBlue", "value": 351.8138780000001}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1117.31843575419], "unit": "score", "name": "RayTrace", "value": 662.290155}, {"lowerIsBetter": false, "replicates": [701.7543859649123], "unit": "score", "name": "Earley", "value": 949.7097749999995}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [43085.10638297872], "unit": "score", "name": "RegExp", "value": 21.14384938271604}, {"lowerIsBetter": false, "replicates": [608.272506082725], "unit": "score", "name": "Splay", "value": 133.97120400000006}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20171.00618639751}]} 03:58:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20171.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1556.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6219.53"}}} 03:58:04 INFO - Return code: 0 03:58:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:58:04 INFO - # TBPL SUCCESS # 03:58:04 INFO - Running post-action listener: _resource_record_post_action 03:58:04 INFO - Running post-run listener: _resource_record_post_run 03:58:05 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 379580416; Read time: 0; Write time: 338960 03:58:05 INFO - install - Wall time: 16s; CPU: 12.0%; Read bytes: 0; Write bytes: 74706944; Read time: 0; Write time: 51480 03:58:05 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 304873472; Read time: 0; Write time: 287480 03:58:05 INFO - Running post-run listener: _upload_blobber_files 03:58:05 INFO - Blob upload gear active. 03:58:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:58:05 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 03:58:05 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'] 03:58:05 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 03:58:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:58:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:58:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:58:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:06 INFO - (blobuploader) - INFO - Done attempting. 03:58:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:58:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:58:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:07 INFO - (blobuploader) - INFO - Done attempting. 03:58:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:58:07 INFO - Return code: 0 03:58:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:58:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:58:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a85eb9822f9e0eaf6ac404f08f29d186699c2530e332ce89f4a35fbdd0c7cbd3a4f4e2bcfa23263e80ae9df5d849007b474155547f10727a9b5778574b4795d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1931251887f265f3240576f58502c326212d0749e8ae2974278e8487fec3a49b940f0dde6c476fd89b2e6779a6238f2192f3642fb64c8a6868bcab2cfc921389"} 03:58:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:58:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:58:07 INFO - Contents: 03:58:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a85eb9822f9e0eaf6ac404f08f29d186699c2530e332ce89f4a35fbdd0c7cbd3a4f4e2bcfa23263e80ae9df5d849007b474155547f10727a9b5778574b4795d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1931251887f265f3240576f58502c326212d0749e8ae2974278e8487fec3a49b940f0dde6c476fd89b2e6779a6238f2192f3642fb64c8a6868bcab2cfc921389"} 03:58:07 INFO - Copying logs to upload dir... 03:58:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1299.320802 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-01-13 03:58:07.024828) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 03:58:07.028515) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155 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/a85eb9822f9e0eaf6ac404f08f29d186699c2530e332ce89f4a35fbdd0c7cbd3a4f4e2bcfa23263e80ae9df5d849007b474155547f10727a9b5778574b4795d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1931251887f265f3240576f58502c326212d0749e8ae2974278e8487fec3a49b940f0dde6c476fd89b2e6779a6238f2192f3642fb64c8a6868bcab2cfc921389"} build_url:https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011594 build_url: 'https://queue.taskcluster.net/v1/task/dGH54teAQRG6cUu_tUrzdg/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/a85eb9822f9e0eaf6ac404f08f29d186699c2530e332ce89f4a35fbdd0c7cbd3a4f4e2bcfa23263e80ae9df5d849007b474155547f10727a9b5778574b4795d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1931251887f265f3240576f58502c326212d0749e8ae2974278e8487fec3a49b940f0dde6c476fd89b2e6779a6238f2192f3642fb64c8a6868bcab2cfc921389"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 03:58:07.053485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:58:07.053813) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452683745.566820-857277155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:58:07.138043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 03:58:07.138366) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 03:58:07.138673) ========= ========= Total master_lag: 0.25 =========