builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1451097627.31 results: success (0) buildid: 20151225171749 builduid: 2c1f0cc28a05488cb199bdaa71fca73b revision: 691f2e687e46d1b166b88b0a3f9dbd480bff9afa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.311637) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.312133) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.312443) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006300 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.338569) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.338874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.351921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.352235) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.400641) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.400935) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.401311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.401579) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-25 18:40: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% 220M=0s 2015-12-25 18:40:27 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187573 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.601773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.602132) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017818 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.652037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:27.652419) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 691f2e687e46d1b166b88b0a3f9dbd480bff9afa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 691f2e687e46d1b166b88b0a3f9dbd480bff9afa --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=cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-25 18:40:27,974 truncating revision to first 12 chars 2015-12-25 18:40:27,974 Setting DEBUG logging. 2015-12-25 18:40:27,974 attempt 1/10 2015-12-25 18:40:27,974 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/691f2e687e46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-25 18:40:28,220 unpacking tar archive at: mozilla-central-691f2e687e46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:28.181700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:28.182013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:28.191675) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:28.191930) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 18:40:28.192351) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-25 18:40:28.192643) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:40:28 INFO - MultiFileLogger online at 20151225 18:40:28 in /builds/slave/test 18:40:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:40:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:40:28 INFO - {'append_to_log': False, 18:40:28 INFO - 'base_work_dir': '/builds/slave/test', 18:40:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:40:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:40:28 INFO - 'branch': 'Firefox-Non-PGO', 18:40:28 INFO - 'buildbot_json_path': 'buildprops.json', 18:40:28 INFO - 'config_files': ('talos/linux_config.py',), 18:40:28 INFO - 'default_actions': ('clobber', 18:40:28 INFO - 'read-buildbot-config', 18:40:28 INFO - 'download-and-extract', 18:40:28 INFO - 'populate-webroot', 18:40:28 INFO - 'create-virtualenv', 18:40:28 INFO - 'install', 18:40:28 INFO - 'run-tests'), 18:40:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:40:28 INFO - 'download_minidump_stackwalk': True, 18:40:28 INFO - 'download_symbols': 'ondemand', 18:40:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:40:28 INFO - 'tooltool.py': '/tools/tooltool.py', 18:40:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:40:28 INFO - '/tools/misc-python/virtualenv.py')}, 18:40:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:40:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:40:28 INFO - 'installer_path': 'installer.exe', 18:40:28 INFO - 'log_level': 'info', 18:40:28 INFO - 'log_name': 'talos', 18:40:28 INFO - 'log_to_console': True, 18:40:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:40:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:40:28 INFO - 'opt_config_files': (), 18:40:28 INFO - 'pip_index': False, 18:40:28 INFO - 'sps_profile': False, 18:40:28 INFO - 'sps_profile_interval': 0, 18:40:28 INFO - 'suite': 'dromaeojs', 18:40:28 INFO - 'system_bits': '64', 18:40:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:40:28 INFO - 'title': 'talos-linux64-ix-010', 18:40:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:40:28 INFO - 'use_talos_json': True, 18:40:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:40:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:40:28 INFO - 'work_dir': 'build'} 18:40:28 INFO - ##### 18:40:28 INFO - ##### Running clobber step. 18:40:28 INFO - ##### 18:40:28 INFO - Running pre-action listener: _resource_record_pre_action 18:40:28 INFO - Running main action method: clobber 18:40:28 INFO - rmtree: /builds/slave/test/build 18:40:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:40:29 INFO - Running post-action listener: _resource_record_post_action 18:40:29 INFO - ##### 18:40:29 INFO - ##### Running read-buildbot-config step. 18:40:29 INFO - ##### 18:40:29 INFO - Running pre-action listener: _resource_record_pre_action 18:40:29 INFO - Running main action method: read_buildbot_config 18:40:29 INFO - Using buildbot properties: 18:40:29 INFO - { 18:40:29 INFO - "project": "", 18:40:29 INFO - "product": "firefox", 18:40:29 INFO - "script_repo_revision": "production", 18:40:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:40:29 INFO - "repository": "", 18:40:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:40:29 INFO - "buildid": "20151225171749", 18:40:29 INFO - "pgo_build": "False", 18:40:29 INFO - "basedir": "/builds/slave/test", 18:40:29 INFO - "buildnumber": 417, 18:40:29 INFO - "slavename": "talos-linux64-ix-010", 18:40:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:40:29 INFO - "platform": "ubuntu64_hw", 18:40:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:40:29 INFO - "branch": "mozilla-central", 18:40:29 INFO - "repo_path": "mozilla-central", 18:40:29 INFO - "revision": "691f2e687e46d1b166b88b0a3f9dbd480bff9afa", 18:40:29 INFO - "stage_platform": "linux64", 18:40:29 INFO - "builduid": "2c1f0cc28a05488cb199bdaa71fca73b", 18:40:29 INFO - "slavebuilddir": "test" 18:40:29 INFO - } 18:40:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:40:29 INFO - Running post-action listener: _resource_record_post_action 18:40:29 INFO - ##### 18:40:29 INFO - ##### Running download-and-extract step. 18:40:29 INFO - ##### 18:40:29 INFO - Running pre-action listener: _resource_record_pre_action 18:40:29 INFO - Running main action method: download_and_extract 18:40:29 INFO - mkdir: /builds/slave/test/build/tests 18:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:29 INFO - https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:40:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/test_packages.json 18:40:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/test_packages.json 18:40:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:40:31 INFO - Downloaded 1302 bytes. 18:40:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:40:31 INFO - Using the following test package requirements: 18:40:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:40:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:40:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:31 INFO - u'jsshell-linux-x86_64.zip'], 18:40:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:40:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:40:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:40:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:40:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:40:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:40:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:40:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:31 INFO - https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:40:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/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 18:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/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 18:40:44 INFO - Downloaded 21941021 bytes. 18:40:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:40:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:40:45 INFO - Return code: 0 18:40:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:45 INFO - https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:40:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/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 18:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/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 18:40:47 INFO - Downloaded 21941021 bytes. 18:40: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 18:40:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40: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 18:40:48 INFO - Return code: 0 18:40: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')]} 18:40:48 INFO - https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:40:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:40:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:40:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/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 18:40:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/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 18:40:49 INFO - Downloaded 11132270 bytes. 18:40:49 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 18:40:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:40:49 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 18:40:50 INFO - Return code: 0 18:40:50 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')]} 18:40:50 INFO - https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:40:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:40:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:40:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/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 18:40:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHiR66EzRRC3KMoF4sdqTA/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 18:40:51 INFO - Downloaded 53324000 bytes. 18:40:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:40:51 INFO - mkdir: /builds/slave/test/properties 18:40:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:40:51 INFO - Writing to file /builds/slave/test/properties/build_url 18:40:51 INFO - Contents: 18:40:51 INFO - build_url:https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:40:51 INFO - Running post-action listener: _resource_record_post_action 18:40:51 INFO - Running post-action listener: set_extra_try_arguments 18:40:51 INFO - ##### 18:40:51 INFO - ##### Running populate-webroot step. 18:40:51 INFO - ##### 18:40:51 INFO - Running pre-action listener: _resource_record_pre_action 18:40:51 INFO - Running main action method: populate_webroot 18:40:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:40:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:40:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:40:51 INFO - '--tppagecycles', 18:40:51 INFO - '7'], 18:40:51 INFO - 'tests': ['tsvgm']}}, 18:40:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:40:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:40:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:40:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:40:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:40:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:40:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:51 INFO - 'talos_options': ['--e10s'], 18:40:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:51 INFO - 'tests': ['damp', 'tps']}, 18:40:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:51 INFO - 'talos_options': ['--e10s'], 18:40:51 INFO - 'tests': ['damp', 'tps']}, 18:40:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:40:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:40:51 INFO - 'other': {'tests': ['a11yr', 18:40:51 INFO - 'ts_paint', 18:40:51 INFO - 'tpaint', 18:40:51 INFO - 'sessionrestore', 18:40:51 INFO - 'sessionrestore_no_auto_restore']}, 18:40:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:40:51 INFO - 'tests': ['a11yr', 18:40:51 INFO - 'ts_paint', 18:40:51 INFO - 'tpaint', 18:40:51 INFO - 'sessionrestore', 18:40:51 INFO - 'sessionrestore_no_auto_restore']}, 18:40:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:40:51 INFO - 'tests': ['a11yr', 18:40:51 INFO - 'ts_paint', 18:40:51 INFO - 'tpaint', 18:40:51 INFO - 'sessionrestore', 18:40:51 INFO - 'sessionrestore_no_auto_restore']}, 18:40:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:40:51 INFO - 'tests': ['a11yr', 18:40:51 INFO - 'ts_paint', 18:40:51 INFO - 'tpaint', 18:40:51 INFO - 'sessionrestore', 18:40:51 INFO - 'sessionrestore_no_auto_restore']}, 18:40:51 INFO - 'other_l64': {'tests': ['a11yr', 18:40:51 INFO - 'ts_paint', 18:40:51 INFO - 'tpaint', 18:40:51 INFO - 'sessionrestore', 18:40:51 INFO - 'sessionrestore_no_auto_restore']}, 18:40:51 INFO - 'other_nol64': {'tests': ['a11yr', 18:40:51 INFO - 'ts_paint', 18:40:51 INFO - 'tpaint', 18:40:51 INFO - 'sessionrestore', 18:40:51 INFO - 'sessionrestore_no_auto_restore']}, 18:40:51 INFO - 'svgr': {'tests': ['tsvgx', 18:40:51 INFO - 'tsvgr_opacity', 18:40:51 INFO - 'tart', 18:40:51 INFO - 'tscrollx', 18:40:51 INFO - 'cart']}, 18:40:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:40:51 INFO - 'tests': ['tsvgx', 18:40:51 INFO - 'tsvgr_opacity', 18:40:51 INFO - 'tart', 18:40:51 INFO - 'tscrollx', 18:40:51 INFO - 'cart']}, 18:40:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:51 INFO - 'tests': ['tp5o']}, 18:40:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:51 INFO - 'talos_options': ['--e10s'], 18:40:51 INFO - 'tests': ['tp5o']}, 18:40:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:51 INFO - 'talos_options': ['--xperf_path', 18:40:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:51 INFO - 'tests': ['tp5n']}, 18:40:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:51 INFO - 'talos_options': ['--e10s', 18:40:51 INFO - '--xperf_path', 18:40:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:51 INFO - 'tests': ['tp5n']}}, 18:40:51 INFO - 'talos.zip': {'path': '', 18:40:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:40:51 INFO - Running post-action listener: _resource_record_post_action 18:40:51 INFO - ##### 18:40:51 INFO - ##### Running create-virtualenv step. 18:40:51 INFO - ##### 18:40:51 INFO - Running pre-action listener: _resource_record_pre_action 18:40:51 INFO - Running main action method: create_virtualenv 18:40:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:40:51 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 18:40:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:40:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:40:51 INFO - Using real prefix '/usr' 18:40:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:40:51 INFO - Installing distribute.............................................................................................................................................................................................done. 18:40:53 INFO - Installing pip.................done. 18:40:53 INFO - Return code: 0 18:40:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:53 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 0x7f382073ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', '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 18:40:53 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 18:40:53 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 18:40:53 INFO - Using env: {'DISPLAY': ':0', 18:40:53 INFO - 'HOME': '/home/cltbld', 18:40:53 INFO - 'LANG': 'en_US.UTF-8', 18:40:53 INFO - 'LANGUAGE': 'en_US:en', 18:40:53 INFO - 'LOGNAME': 'cltbld', 18:40:53 INFO - 'MAIL': '/var/mail/cltbld', 18:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:53 INFO - 'MOZ_NO_REMOTE': '1', 18:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:53 INFO - 'NO_EM_RESTART': '1', 18:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:53 INFO - 'PWD': '/builds/slave/test', 18:40:53 INFO - 'SHELL': '/bin/bash', 18:40:53 INFO - 'SHLVL': '1', 18:40:53 INFO - 'TERM': 'linux', 18:40:53 INFO - 'TMOUT': '86400', 18:40:53 INFO - 'USER': 'cltbld', 18:40:53 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:53 INFO - '_': '/tools/buildbot/bin/python'} 18:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:54 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 18:40:54 INFO - Cleaning up... 18:40:54 INFO - Return code: 0 18:40:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:40:54 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')]} 18:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:54 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')]} 18:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:54 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 0x7f382073ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', '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 18:40:54 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 18:40:54 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 18:40:54 INFO - Using env: {'DISPLAY': ':0', 18:40:54 INFO - 'HOME': '/home/cltbld', 18:40:54 INFO - 'LANG': 'en_US.UTF-8', 18:40:54 INFO - 'LANGUAGE': 'en_US:en', 18:40:54 INFO - 'LOGNAME': 'cltbld', 18:40:54 INFO - 'MAIL': '/var/mail/cltbld', 18:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:54 INFO - 'MOZ_NO_REMOTE': '1', 18:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:54 INFO - 'NO_EM_RESTART': '1', 18:40:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:54 INFO - 'PWD': '/builds/slave/test', 18:40:54 INFO - 'SHELL': '/bin/bash', 18:40:54 INFO - 'SHLVL': '1', 18:40:54 INFO - 'TERM': 'linux', 18:40:54 INFO - 'TMOUT': '86400', 18:40:54 INFO - 'USER': 'cltbld', 18:40:54 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:54 INFO - '_': '/tools/buildbot/bin/python'} 18:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:54 INFO - Downloading/unpacking psutil>=0.7.1 18:40:54 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 18:40:54 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 18:40:54 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 18:40:54 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 18:40:54 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 18:40:54 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 18:40:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:40:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:40:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:56 INFO - Installing collected packages: psutil 18:40:56 INFO - Running setup.py install for psutil 18:40:56 INFO - building 'psutil._psutil_linux' extension 18:40:56 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 18:40:56 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 18:40:56 INFO - building 'psutil._psutil_posix' extension 18:40:56 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 18:40:56 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 18:40:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:56 INFO - Successfully installed psutil 18:40:56 INFO - Cleaning up... 18:40:56 INFO - Return code: 0 18:40:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:40: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')]} 18:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40: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')]} 18:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:56 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 0x7f382073ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', '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 18:40:56 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 18:40:56 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 18:40:56 INFO - Using env: {'DISPLAY': ':0', 18:40:56 INFO - 'HOME': '/home/cltbld', 18:40:56 INFO - 'LANG': 'en_US.UTF-8', 18:40:56 INFO - 'LANGUAGE': 'en_US:en', 18:40:56 INFO - 'LOGNAME': 'cltbld', 18:40:56 INFO - 'MAIL': '/var/mail/cltbld', 18:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:56 INFO - 'MOZ_NO_REMOTE': '1', 18:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:56 INFO - 'NO_EM_RESTART': '1', 18:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:56 INFO - 'PWD': '/builds/slave/test', 18:40:56 INFO - 'SHELL': '/bin/bash', 18:40:56 INFO - 'SHLVL': '1', 18:40:56 INFO - 'TERM': 'linux', 18:40:56 INFO - 'TMOUT': '86400', 18:40:56 INFO - 'USER': 'cltbld', 18:40:56 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:56 INFO - '_': '/tools/buildbot/bin/python'} 18:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:40:56 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 18:40:56 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 18:40:56 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 18:40:56 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 18:40:56 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 18:40:56 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 18:40:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:40:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:40:58 INFO - Installing collected packages: mozsystemmonitor 18:40:58 INFO - Running setup.py install for mozsystemmonitor 18:40:58 INFO - Successfully installed mozsystemmonitor 18:40:58 INFO - Cleaning up... 18:40:58 INFO - Return code: 0 18:40:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:40:58 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')]} 18:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:58 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')]} 18:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:58 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 0x7f382073ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', '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 18:40:58 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 18:40:58 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 18:40:58 INFO - Using env: {'DISPLAY': ':0', 18:40:58 INFO - 'HOME': '/home/cltbld', 18:40:58 INFO - 'LANG': 'en_US.UTF-8', 18:40:58 INFO - 'LANGUAGE': 'en_US:en', 18:40:58 INFO - 'LOGNAME': 'cltbld', 18:40:58 INFO - 'MAIL': '/var/mail/cltbld', 18:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:58 INFO - 'MOZ_NO_REMOTE': '1', 18:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:58 INFO - 'NO_EM_RESTART': '1', 18:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:58 INFO - 'PWD': '/builds/slave/test', 18:40:58 INFO - 'SHELL': '/bin/bash', 18:40:58 INFO - 'SHLVL': '1', 18:40:58 INFO - 'TERM': 'linux', 18:40:58 INFO - 'TMOUT': '86400', 18:40:58 INFO - 'USER': 'cltbld', 18:40:58 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:58 INFO - '_': '/tools/buildbot/bin/python'} 18:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:40:58 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 18:40:58 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 18:40:58 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 18:40:58 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 18:40:58 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 18:40:58 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 18:41:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:41:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:41:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:41:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:41:01 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 18:41:01 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 18:41:01 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 18:41:01 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 18:41:01 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 18:41:01 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 18:41:01 INFO - Downloading docopt-0.6.1.tar.gz 18:41:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:41:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:41:01 INFO - Running setup.py install for blobuploader 18:41:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:41:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:41:01 INFO - Running setup.py install for requests 18:41:01 INFO - Running setup.py install for docopt 18:41:01 INFO - Successfully installed blobuploader requests docopt 18:41:01 INFO - Cleaning up... 18:41:01 INFO - Return code: 0 18:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:01 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')]} 18:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:01 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')]} 18:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:01 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 0x7f382073ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', '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 18:41:01 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 18:41:01 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 18:41:01 INFO - Using env: {'DISPLAY': ':0', 18:41:01 INFO - 'HOME': '/home/cltbld', 18:41:01 INFO - 'LANG': 'en_US.UTF-8', 18:41:01 INFO - 'LANGUAGE': 'en_US:en', 18:41:01 INFO - 'LOGNAME': 'cltbld', 18:41:01 INFO - 'MAIL': '/var/mail/cltbld', 18:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:01 INFO - 'MOZ_NO_REMOTE': '1', 18:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:01 INFO - 'NO_EM_RESTART': '1', 18:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:01 INFO - 'PWD': '/builds/slave/test', 18:41:01 INFO - 'SHELL': '/bin/bash', 18:41:01 INFO - 'SHLVL': '1', 18:41:01 INFO - 'TERM': 'linux', 18:41:01 INFO - 'TMOUT': '86400', 18:41:01 INFO - 'USER': 'cltbld', 18:41:01 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:01 INFO - '_': '/tools/buildbot/bin/python'} 18:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:02 INFO - Running setup.py (path:/tmp/pip-7KTvw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:02 INFO - Running setup.py (path:/tmp/pip-bCPTCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:02 INFO - Running setup.py (path:/tmp/pip-D4Ez0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:02 INFO - Running setup.py (path:/tmp/pip-V3Dlnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:02 INFO - Running setup.py (path:/tmp/pip-EWeR6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:02 INFO - Running setup.py (path:/tmp/pip-ZFxRi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:02 INFO - Running setup.py (path:/tmp/pip-HcoiZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:02 INFO - Running setup.py (path:/tmp/pip-qnbdpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:02 INFO - Running setup.py (path:/tmp/pip-2UhlMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:02 INFO - Running setup.py (path:/tmp/pip-MtFPSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:02 INFO - Running setup.py (path:/tmp/pip-ZDKy2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:02 INFO - Running setup.py (path:/tmp/pip-BjLhjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:03 INFO - Running setup.py (path:/tmp/pip-QFQOH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:03 INFO - Running setup.py (path:/tmp/pip-bDzjLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:03 INFO - Running setup.py (path:/tmp/pip-u3dIyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:03 INFO - Running setup.py (path:/tmp/pip-w8LHmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:03 INFO - Running setup.py (path:/tmp/pip-VWIqDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:41:03 INFO - Running setup.py install for manifestparser 18:41:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:41:03 INFO - Running setup.py install for mozcrash 18:41:03 INFO - Running setup.py install for mozdebug 18:41:03 INFO - Running setup.py install for mozdevice 18:41:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:41:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:41:03 INFO - Running setup.py install for mozfile 18:41:03 INFO - Running setup.py install for mozhttpd 18:41:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Running setup.py install for mozinfo 18:41:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Running setup.py install for mozInstall 18:41:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Running setup.py install for mozleak 18:41:04 INFO - Running setup.py install for mozlog 18:41:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Running setup.py install for moznetwork 18:41:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Running setup.py install for mozprocess 18:41:04 INFO - Running setup.py install for mozprofile 18:41:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Running setup.py install for mozrunner 18:41:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:41:04 INFO - Running setup.py install for mozscreenshot 18:41:04 INFO - Running setup.py install for moztest 18:41:05 INFO - Running setup.py install for mozversion 18:41:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:41:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:41:05 INFO - Cleaning up... 18:41:05 INFO - Return code: 0 18:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:05 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 0x7f382073ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', '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 18:41:05 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 18:41:05 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 18:41:05 INFO - Using env: {'DISPLAY': ':0', 18:41:05 INFO - 'HOME': '/home/cltbld', 18:41:05 INFO - 'LANG': 'en_US.UTF-8', 18:41:05 INFO - 'LANGUAGE': 'en_US:en', 18:41:05 INFO - 'LOGNAME': 'cltbld', 18:41:05 INFO - 'MAIL': '/var/mail/cltbld', 18:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:05 INFO - 'MOZ_NO_REMOTE': '1', 18:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:05 INFO - 'NO_EM_RESTART': '1', 18:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:05 INFO - 'PWD': '/builds/slave/test', 18:41:05 INFO - 'SHELL': '/bin/bash', 18:41:05 INFO - 'SHLVL': '1', 18:41:05 INFO - 'TERM': 'linux', 18:41:05 INFO - 'TMOUT': '86400', 18:41:05 INFO - 'USER': 'cltbld', 18:41:05 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:05 INFO - '_': '/tools/buildbot/bin/python'} 18:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:05 INFO - Running setup.py (path:/tmp/pip-WA7664-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:05 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)) 18:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:05 INFO - Running setup.py (path:/tmp/pip-86LVtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:05 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)) 18:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:05 INFO - Running setup.py (path:/tmp/pip-CeWT6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:05 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)) 18:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:05 INFO - Running setup.py (path:/tmp/pip-bsRpSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:05 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)) 18:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:05 INFO - Running setup.py (path:/tmp/pip-ivEbVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:05 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)) 18:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:05 INFO - Running setup.py (path:/tmp/pip-0AbPLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:05 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)) 18:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:05 INFO - Running setup.py (path:/tmp/pip-jCCcAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:05 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)) 18:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:05 INFO - Running setup.py (path:/tmp/pip-a9SPBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:05 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)) 18:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:05 INFO - Running setup.py (path:/tmp/pip-bNJaFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:06 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)) 18:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:06 INFO - Running setup.py (path:/tmp/pip-zwrAAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:06 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)) 18:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:06 INFO - Running setup.py (path:/tmp/pip-AaioSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:06 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)) 18:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:06 INFO - Running setup.py (path:/tmp/pip-GEbTOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:06 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)) 18:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:06 INFO - Running setup.py (path:/tmp/pip-omokbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:06 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)) 18:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:06 INFO - Running setup.py (path:/tmp/pip-4TnfgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:06 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)) 18:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:06 INFO - Running setup.py (path:/tmp/pip-fTWTaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:06 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)) 18:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:06 INFO - Running setup.py (path:/tmp/pip-7LDudb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:06 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)) 18:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:06 INFO - Running setup.py (path:/tmp/pip-BkDSpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:06 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)) 18:41:06 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)) 18:41:06 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)) 18:41:06 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)) 18:41:06 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)) 18:41:06 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)) 18:41:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:08 INFO - Downloading blessings-1.5.1.tar.gz 18:41:08 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 18:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:41:08 INFO - Installing collected packages: blessings 18:41:08 INFO - Running setup.py install for blessings 18:41:08 INFO - Successfully installed blessings 18:41:08 INFO - Cleaning up... 18:41:08 INFO - Return code: 0 18:41:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:08 INFO - Reading from file tmpfile_stdout 18:41:08 INFO - Current package versions: 18:41:08 INFO - argparse == 1.2.1 18:41:08 INFO - blessings == 1.5.1 18:41:08 INFO - blobuploader == 1.2.4 18:41:08 INFO - docopt == 0.6.1 18:41:08 INFO - manifestparser == 1.1 18:41:08 INFO - mozInstall == 1.12 18:41:08 INFO - mozcrash == 0.16 18:41:08 INFO - mozdebug == 0.1 18:41:08 INFO - mozdevice == 0.47 18:41:08 INFO - mozfile == 1.2 18:41:08 INFO - mozhttpd == 0.7 18:41:08 INFO - mozinfo == 0.9 18:41:08 INFO - mozleak == 0.1 18:41:08 INFO - mozlog == 3.1 18:41:08 INFO - moznetwork == 0.27 18:41:08 INFO - mozprocess == 0.22 18:41:08 INFO - mozprofile == 0.28 18:41:08 INFO - mozrunner == 6.11 18:41:08 INFO - mozscreenshot == 0.1 18:41:08 INFO - mozsystemmonitor == 0.0 18:41:08 INFO - moztest == 0.7 18:41:08 INFO - mozversion == 1.4 18:41:08 INFO - psutil == 3.1.1 18:41:08 INFO - requests == 1.2.3 18:41:08 INFO - wsgiref == 0.1.2 18:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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', '-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 0x7f382073ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', '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 18:41:08 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 18:41:08 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 18:41:08 INFO - Using env: {'DISPLAY': ':0', 18:41:08 INFO - 'HOME': '/home/cltbld', 18:41:08 INFO - 'LANG': 'en_US.UTF-8', 18:41:08 INFO - 'LANGUAGE': 'en_US:en', 18:41:08 INFO - 'LOGNAME': 'cltbld', 18:41:08 INFO - 'MAIL': '/var/mail/cltbld', 18:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:08 INFO - 'MOZ_NO_REMOTE': '1', 18:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:08 INFO - 'NO_EM_RESTART': '1', 18:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:08 INFO - 'PWD': '/builds/slave/test', 18:41:08 INFO - 'SHELL': '/bin/bash', 18:41:08 INFO - 'SHLVL': '1', 18:41:08 INFO - 'TERM': 'linux', 18:41:08 INFO - 'TMOUT': '86400', 18:41:08 INFO - 'USER': 'cltbld', 18:41:08 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:08 INFO - '_': '/tools/buildbot/bin/python'} 18:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 INFO - Cleaning up... 18:41:09 INFO - Return code: 0 18:41:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:41:09 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')]} 18:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:09 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')]} 18:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:09 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 0x7f382073ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', '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 18:41:09 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 18:41:09 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 18:41:09 INFO - Using env: {'DISPLAY': ':0', 18:41:09 INFO - 'HOME': '/home/cltbld', 18:41:09 INFO - 'LANG': 'en_US.UTF-8', 18:41:09 INFO - 'LANGUAGE': 'en_US:en', 18:41:09 INFO - 'LOGNAME': 'cltbld', 18:41:09 INFO - 'MAIL': '/var/mail/cltbld', 18:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:09 INFO - 'MOZ_NO_REMOTE': '1', 18:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:09 INFO - 'NO_EM_RESTART': '1', 18:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:09 INFO - 'PWD': '/builds/slave/test', 18:41:09 INFO - 'SHELL': '/bin/bash', 18:41:09 INFO - 'SHLVL': '1', 18:41:09 INFO - 'TERM': 'linux', 18:41:09 INFO - 'TMOUT': '86400', 18:41:09 INFO - 'USER': 'cltbld', 18:41:09 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:09 INFO - '_': '/tools/buildbot/bin/python'} 18:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:09 INFO - Downloading/unpacking jsonschema 18:41:09 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 18:41:09 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 18:41:09 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 18:41:09 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 18:41:09 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 18:41:09 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 18:41:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:41:10 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 18:41:10 INFO - Downloading/unpacking functools32 (from jsonschema) 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41:11 INFO - Downloading functools32-3.2.3-2.tar.gz 18:41:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:41:11 INFO - warning: no files found matching '*.txt' 18:41:11 INFO - no previously-included directories found matching 'build' 18:41:11 INFO - no previously-included directories found matching 'dist' 18:41:11 INFO - no previously-included directories found matching '.git*' 18:41:11 INFO - Installing collected packages: jsonschema, functools32 18:41:11 INFO - Running setup.py install for functools32 18:41:11 INFO - warning: no files found matching '*.txt' 18:41:11 INFO - no previously-included directories found matching 'build' 18:41:11 INFO - no previously-included directories found matching 'dist' 18:41:11 INFO - no previously-included directories found matching '.git*' 18:41:11 INFO - Successfully installed jsonschema functools32 18:41:11 INFO - Cleaning up... 18:41:11 INFO - Return code: 0 18:41:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f382073ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', '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 18:41:11 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 18:41:11 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 18:41:11 INFO - Using env: {'DISPLAY': ':0', 18:41:11 INFO - 'HOME': '/home/cltbld', 18:41:11 INFO - 'LANG': 'en_US.UTF-8', 18:41:11 INFO - 'LANGUAGE': 'en_US:en', 18:41:11 INFO - 'LOGNAME': 'cltbld', 18:41:11 INFO - 'MAIL': '/var/mail/cltbld', 18:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:11 INFO - 'MOZ_NO_REMOTE': '1', 18:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:11 INFO - 'NO_EM_RESTART': '1', 18:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:11 INFO - 'PWD': '/builds/slave/test', 18:41:11 INFO - 'SHELL': '/bin/bash', 18:41:11 INFO - 'SHLVL': '1', 18:41:11 INFO - 'TERM': 'linux', 18:41:11 INFO - 'TMOUT': '86400', 18:41:11 INFO - 'USER': 'cltbld', 18:41:11 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:11 INFO - '_': '/tools/buildbot/bin/python'} 18:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:11 INFO - Downloading/unpacking flake8 18:41:11 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 18:41:11 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 18:41:11 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 18:41:11 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 18:41:11 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 18:41:11 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 18:41:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:41:13 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 18:41:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:41:13 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 18:41:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41:13 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 18:41:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:41:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:41:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:41:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:41:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:41:13 INFO - no previously-included directories found matching 'docs/_build' 18:41:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:41:14 INFO - Running setup.py install for pep8 18:41:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:41:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:41:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:41:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:41:14 INFO - no previously-included directories found matching 'docs/_build' 18:41:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:41:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:41:14 INFO - Cleaning up... 18:41:14 INFO - Return code: 0 18:41:14 INFO - Running post-action listener: _resource_record_post_action 18:41:14 INFO - Running post-action listener: _start_resource_monitoring 18:41:14 INFO - Starting resource monitoring. 18:41:14 INFO - ##### 18:41:14 INFO - ##### Running install step. 18:41:14 INFO - ##### 18:41:14 INFO - Running pre-action listener: _resource_record_pre_action 18:41:14 INFO - Running main action method: install 18:41:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:14 INFO - Reading from file tmpfile_stdout 18:41:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:41:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:41:14 INFO - Reading from file tmpfile_stdout 18:41:14 INFO - Output received: 18:41:14 INFO - Usage: mozinstall [options] installer 18:41:14 INFO - Options: 18:41:14 INFO - -h, --help show this help message and exit 18:41:14 INFO - -d DEST, --destination=DEST 18:41:14 INFO - Directory to install application into. [default: 18:41:14 INFO - "/builds/slave/test"] 18:41:14 INFO - --app=APP Application being installed. [default: firefox] 18:41:14 INFO - mkdir: /builds/slave/test/build/application 18:41:14 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'] 18:41:14 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 18:41:30 INFO - Reading from file tmpfile_stdout 18:41:30 INFO - Output received: 18:41:30 INFO - /builds/slave/test/build/application/firefox/firefox 18:41:30 INFO - Running post-action listener: _resource_record_post_action 18:41:30 INFO - ##### 18:41:30 INFO - ##### Running run-tests step. 18:41:30 INFO - ##### 18:41:30 INFO - Running pre-action listener: _resource_record_pre_action 18:41:30 INFO - Running main action method: run_tests 18:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:41:30 INFO - Python 2.7.3 18:41:30 INFO - Return code: 0 18:41:30 INFO - grabbing minidump binary from tooltool 18:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:30 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 0x2ba43d0>, '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 0x2b0fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:41:30 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 18:41:30 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 18:41:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:41:30 INFO - Return code: 0 18:41:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:41:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:41:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:41:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:41:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:41:31 INFO - Return code: 0 18:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:41:31 INFO - Using env: {'DISPLAY': ':0', 18:41:31 INFO - 'HOME': '/home/cltbld', 18:41:31 INFO - 'LANG': 'en_US.UTF-8', 18:41:31 INFO - 'LANGUAGE': 'en_US:en', 18:41:31 INFO - 'LOGNAME': 'cltbld', 18:41:31 INFO - 'MAIL': '/var/mail/cltbld', 18:41:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:41:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:31 INFO - 'MOZ_NO_REMOTE': '1', 18:41:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:31 INFO - 'NO_EM_RESTART': '1', 18:41:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:31 INFO - 'PWD': '/builds/slave/test', 18:41:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:41:31 INFO - 'SHELL': '/bin/bash', 18:41:31 INFO - 'SHLVL': '1', 18:41:31 INFO - 'TERM': 'linux', 18:41:31 INFO - 'TMOUT': '86400', 18:41:31 INFO - 'USER': 'cltbld', 18:41:31 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719', 18:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:31 INFO - '_': '/tools/buildbot/bin/python'} 18:41:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:41:31 INFO - mozversion application_buildid: 20151225171749 18:41:31 INFO - mozversion application_changeset: 691f2e687e46d1b166b88b0a3f9dbd480bff9afa 18:41:31 INFO - mozversion application_display_name: Nightly 18:41:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:41:31 INFO - mozversion application_name: Firefox 18:41:31 INFO - mozversion application_remotingname: firefox 18:41:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:41:31 INFO - mozversion application_vendor: Mozilla 18:41:31 INFO - mozversion application_version: 46.0a1 18:41:31 INFO - mozversion platform_buildid: 20151225171749 18:41:31 INFO - mozversion platform_changeset: 691f2e687e46d1b166b88b0a3f9dbd480bff9afa 18:41:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:41:31 INFO - mozversion platform_version: 46.0a1 18:41:31 INFO - using testdate: 1451097691 18:41:31 INFO - actual date: 1451097691 18:41:31 INFO - starting webserver on 'localhost:36683' 18:41:31 INFO - SUITE-START | Running 3 tests 18:41:31 INFO - TEST-START | dromaeo_css 18:41:31 INFO - operating with platform_type : linux_ 18:41:31 INFO - Initialising browser for dromaeo_css test... 18:41:31 INFO - TEST-INFO | started process 6267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgPoKEH/profile http://localhost:36683/getInfo.html) 18:41:35 INFO - PROCESS | 6267 | __metrics Screen width/height:1600/1200 18:41:35 INFO - PROCESS | 6267 | colorDepth:24 18:41:35 INFO - PROCESS | 6267 | Browser inner width/height: 1024/697 18:41:35 INFO - PROCESS | 6267 | __metrics 18:41:35 INFO - PROCESS | 6267 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:41:35 INFO - PROCESS | 6267 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:41:36 INFO - TEST-INFO | 6267: exit 0 18:41:36 INFO - Browser initialized. 18:41:36 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:36 INFO - TEST-INFO | started process 6363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgPoKEH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:48 INFO - PROCESS | 6363 | RSS: Main: 151351296 18:41:48 INFO - PROCESS | 6363 | 18:42:39 INFO - PROCESS | 6363 | 1451097759857 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] 18:44:51 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:36683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36683/tests/dromaeo/cssquery-ext.html) 18:44:52 INFO - PROCESS | 6363 | RSS: Main: 242601984 18:44:52 INFO - PROCESS | 6363 | 18:47:55 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:36683/tests/dromaeo/cssquery-ext.html (next: http://localhost:36683/tests/dromaeo/cssquery-jquery.html) 18:47:55 INFO - PROCESS | 6363 | RSS: Main: 222879744 18:47:55 INFO - PROCESS | 6363 | 18:50:57 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:36683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36683/tests/dromaeo/cssquery-mootools.html) 18:50:58 INFO - PROCESS | 6363 | RSS: Main: 218271744 18:50:58 INFO - PROCESS | 6363 | 18:54:00 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:36683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36683/tests/dromaeo/cssquery-prototype.html) 18:54:00 INFO - PROCESS | 6363 | RSS: Main: 209432576 18:54:00 INFO - PROCESS | 6363 | 18:57:03 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:36683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36683/tests/dromaeo/cssquery-yui.html) 18:57:04 INFO - PROCESS | 6363 | RSS: Main: 214945792 18:57:04 INFO - PROCESS | 6363 | 19:00:06 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:36683/tests/dromaeo/cssquery-yui.html (next: http://localhost:36683/tests/dromaeo/cssquery-dojo.html) 19:00:06 INFO - PROCESS | 6363 | RSS: Main: 257548288 19:00:06 INFO - PROCESS | 6363 | 19:00:06 INFO - PROCESS | 6363 | __start_tp_report 19:00:06 INFO - PROCESS | 6363 | _x_x_mozilla_page_load 19:00:06 INFO - PROCESS | 6363 | _x_x_mozilla_page_load_details 19:00:06 INFO - PROCESS | 6363 | |i|pagename|runs| 19:00:06 INFO - PROCESS | 6363 | |0;dojo.html;2578.213644838324;2660.6408134901794;2663.041305130154;2675.5986602009707;2688.771454426373;4366.519682834885;4487.730736155825;4513.548645135485;4526.592606665404;4547.863564093078;4514.841980530682;4543.659225558088;4576.153411618853;4599.494055653875;4650.23271160259;4159.958400415987;4206.074663574024;4235.216484950286;4282.993496528329;4310.612044915957;4042.090529630839;4234.894127646803;4297.376880352347;4312.504062032875;4348.760818155;4110.6300432961025;4117.3618089196225;4187.183499217654;4272.017435989708;4293.205756934977;4179.644730197937;4183.3515805049965;4192.685548583838;4206.305959516707;4225.535191128974;4168.520620128694;4178.331466965301;4191.517975432834;4206.221848957953;4217.451731274915;4278.080212754242;4398.406215160944;4402.273624851896;4478.484974227973;4578.885527861797;4871.951280487186;4881.829135980259;4885.584725298354;4888.41339039314;4911.680740751875;4887.193613053842;4908.386451693538;4908.852734417973;4934;4946.183879659852;4366.454193225815;4460.219461594208;4463.531329210451;4476.7090139140855;4606.769661516944;4993.6005119590345;5001.374828146481;5003.124453220672;5015.84952451427;5027.924581131286;4814.085323788469;4826.61387089032;4827.348307978448;4828.444728856156;4876.902461950741;4675.836345727883;4742.9762851186215;4778.784954677048;4779.928301075487;4898.093852637274;4820.276958456259;4825.927611085836;4841.249606310957;4850.80596776125;4884.780184891689;4821.975890120527;4823.324734537167;4829.9275510867365;4830.154722923475;4878.365812444359;3950.3481925482547;4021.698372622065;4041.474608300902;4042.7372220805555;4110.23960567296;3628.092976755811;3633.6003039665616;3640.3265395901312;3648.872289469856;3651.032476393758;4234.132002939452;4236.216299984513;4240.766757828349;4242.193983143255;4278.7432754034235;4611.216093264153;4770.6660533763;4781.976090119597;4838.7338696372035;4894.143524883131;4261.403403523509;4266.637335826427;4271.081717430705;4288.31386978082;4292.527821939584;4393;4399.36209249657;4408.140412619508;4409.977950110293;4447.866564003085;4479.619232365155;4595.954040459686;4681.648876334289;4682.789274482725;4727.881802954954;4730.124926888537;4865.70805751656;4933.802647894044;4960.77676504551;4963.925541116959;4667.8599642010795;4688.6483513737285;4690.554397332385;4691.366665500251;4728.219843725747;4683.320918466735;4832.589229915356;4836.492168322276;4839.419269687519;4892.290617860462;4746.145693775154;4762.880927976828;4766.523347665345;4776.808927642855;4874.8537543873745;4720.150372932905;4736.3842700450095;4738.905221895474;4747.145513807548;4785.784639691292;4714.3399924011355;4734.573888350065;4735.573798358164;4737.952620473889;4769.379980602499;4372.278574035376;4392.275274579659;4481.395011673382;4518.390017347616;4618.0994706032;4746.098241334135;4747.715137091785;4756.619470442287;4758.428988521399;4783.617310615073;4646.4191976003;4648.488666246642;4648.628109751279;4692.812287508462;4694.225452800386 19:00:06 INFO - PROCESS | 6363 | |1;ext.html;530.5516838271659;562.6680258647398;572.2532095615222;572.8281515545335;587.985300367491;24928.50142997139;25367.365815854613;32913.506297405525;33060.17349566256;33145.83427082867;37942.24115517688;38919;38926;38965.22069558614;38996.41505377422;6691.197056353244;7460.216677248878;7603.163651998276;7603.619819009027;7605.771826845204;6940.097787287646;9750.756231094208;9985.500724963758;9989.850152247722;9993.200543956465;9562.043795620451;9588;9665;9667.758306042335;9669.226461883032;9629.807403851919;9759.512024398822;9766.658166964158;9781.510924453749;9786.5596048178;9471.10024547667;9623.230141588656;9623.951880240624;9627.807443851154;9855.310128291023;35970.28059438823;36442.27115457676;36486;36500;36523.08692282688;2779.7498225159834;2882.8126171798767;2908.7527560157414;2955.8374289414073;3380.188754698879;27575.448491030267;27900.441991160267;28033.439331213467;28113.437731245464;28260;3327.317899830553;3344.2308269098244;3365.1082463147286;3382.0530251529613;3392.6607339266125;220225;220740;221255;221428;221694.89152554295;43888.780556097016;44664.776676117064;45022.77488612536;51498;52167;54350.728246358514;55443.72278138583;55590;55601.443985560436;55749.72125139349;12485.812712809315;12848.036397270054;12879.806802897963;12883.355832208352;12907.161034532724;9201.907980920105;9260.166585007248;9269.860952085724;9272.536373181314;9276;15275.312610932535;15381.30784114695;15386.846131538541;15925.442609508844;16005.237459831973;7050.964745176344;7234.529755565976;7248.96375518119;7271.091113610799;7334.9266507335315;841.6170642357713;890.4479222881725;891.2068259249273;906.6600024990629;1040.2250323508883;26049.348766280615;26062.34844128912;26193.43054824846;26287.474250515264;26402.207933762016;925.6621333213328;936.2650319499161;953.713885834247;1000.4897502273893;1015.8120747661707;13388.397522111529;13480.258585777876;13603.387847546885;13746.793798093036;13783.448662053406;265270;271009.644951774;271367;271458;271697;44200.3369949451;44507.777461112484;44521.77739111284;44528.55471445244;44591.77704111459;1037.305005646219;1146.2377518949972;1148.8965993060665;1151.2459339132713;1251.9170917156775;23115.190968316027;23688.170914017926;24402.145924892542;24759;25840.353991150372;36396;36683.63316366802;36717;36731.26537469289;36762;226742;231689.5739691684;250335;257756;257861;25625.359366015255;25699;25840.22479325623;25849.22452326358;25873.870630647478;33660.83169584136;36832.26335473329;38511.422328665656;38856;39251.803740981115;31402.21494462565;31697.366052679277;31919.68080319167;32242.677573223966;32371.35257294888;30334.84832575823;33902;34498.31003379868;34865.30269394648;34981.47527787136;31888;32091.839540802146;32239.677603224605;32741.508877367334;32913;25185.24444266675;25919.611205832305;29753.851230744574;30559.54160687547;30661;22427.32718018462;23065.88467057654;24516.264512064667;24927.252182434557;24996.625050624618 19:00:06 INFO - PROCESS | 6363 | |2;jquery.html;334.13125872730893;336.66669996703257;336.88377509759124;337.7821305258109;340.5368698569946;12196.451159697812;12545;14621.561353159408;14974.25128743564;16466.999999999985;8396.496210227391;9815.067568580973;10070.848937265928;13752.381142848595;15514.5345639631;4412.227860124473;4537.115262523809;4541.931871021938;4542.500324964251;4543.250363689987;3334.1831251343456;3428.554287942564;4503.864884053483;5046.671966322196;5206;5172.12073947428;5174.715390653512;5180.378354597454;5185.662931909433;5196.272521846926;5083.491650834905;5163.870903227412;5223.399309079467;5226.634135610509;5229.529342359206;5053.343065401511;5061.468545802674;5065.392152941634;5068.594512438996;5070.163423035195;11102.61140860066;18859.33992310276;18941.905290473598;19120.617587648307;20089.196432142697;1887.3677318098453;1913.2155816115326;1915.4732448576613;1923.4998900285887;1958.177565422526;12908.096433249677;12934.159279646887;13116.737665246641;13285.13646612967;13463.596092117252;1806.2323512507132;1807;1838.6414649143424;1855.2578968412608;1894.6684330242153;48329.04120443747;63530.36469635291;63729.04406433907;63803.36196638067;64111.358886411006;15140.848591513944;15250.923745381424;15314.770278445832;15343.616409589626;15369;22987.195448159233;23013.698630136852;23205.53588928212;23256.4185895354;23313.76686233116;7730.072391313079;7783.377329813601;7900.604969751489;7938.960305198437;8007.199280071946;6353.618782873043;6380.170577824946;6384.776532821329;6394.5843520171975;6399.328070552618;7402.629868506553;7464.253574642492;7480.625968701544;7483.550986940801;7491.9625401872645;2325.54651842889;2859.352778262914;2989.1929179121516;3059.4034163337938;3063.540468929634;714.8677494663503;726.2048057377164;761.9409021460175;846.0862268749859;853.1724227499316;14411.92794036023;15879.444219452263;16578.00531968086;16605.6678866422;17110.230039648246;741.388354607451;851.0808327006818;856.1053698884681;863.1713554987157;889.6841621224502;8918.19736223743;9063.637454501877;9165;9228.446293222429;9324.720258392259;471918;476683.08292292274;508416;521662;542509;69887.65056174686;71596.28403716;72762;73673;73703;1024.882138554061;1029.7477118106112;1037.4605205293205;1037.9896201038043;1039.6361273554346;14053.437862485385;14131.15213087218;14291.356888939814;14301.070430421989;14317.427302907767;33461.330773384885;33648.32703345968;33764.493532597524;33971;35157.29685406329;43384.783076084415;44218.030565873196;44430;44825.32762008638;47947.28079078747;8474.237318641352;8705.782355441164;8950.194482496607;8954.28365730727;8955.149260820212;15367;15403.460878869633;15433.614159646098;15524.767128492857;15856.365745370056;12911.806322904977;13222.933885330513;13298.800517992431;13547.86452135466;13673.863261367656;12633.81049284243;12694.174878632859;13082.607521774362;13127.540536081191;13136.080474366703;12957.416916238602;13331.866681333451;13614.659633509242;13752.174869507862;13884.86115138876;8763;8854.601542930455;8888.11118888132;8893.73318800437;8907.198352148338;9548.809023819624;12661.303628300531;13105.344732763515;13229.933850330686;13719.519816806363 19:00:06 INFO - PROCESS | 6363 | |3;mootools.html;1094.5676457799163;1366.5285476510603;1374.7937809328603;1484.2282013353056;1686.7891513560805;5745.138229265613;6805.285445028268;6876.44988400928;6882.759103431381;6902.206246281679;6683.766068187614;6796.524243302971;6805.251422343538;6819.011243369709;6824.112865327513;1842.0697547738407;1878.1829903991738;1882.6422979633894;1885.0480507343773;1885.057471264368;1916.875403098794;1933.7679478462535;1938.185961896;1991.930282440115;2007.5081605006794;1937.4575118966711;1952.5704345044066;1955.4426988308335;1955.501347156473;1955.716421118937;1905.3426567834144;1936.1190658250462;1942.0969249299073;1942.5823447958758;1943.24213556713;1905.8189472000277;1909.3985394600656;1920.7791104023077;1980.7821139674625;1993.6212119697211;7095.077639906831;7157.284271572853;7181.964090179516;7182.066331376887;7186.1735900371605;4077.938830917539;4138.337865941435;4159.83360665573;4172.666186705056;4176.248275310443;2600.2069368842494;2655.5751079827137;2687.4625074985083;2710.593410988348;2713.4030513287044;799.5043073294595;800.0599295827379;808.3896658023154;814.4990830639114;829.8091438969071;9418.340716149873;9432.481213533252;9458.33791634586;9476.147146756755;9502.144806967337;3710.05393624624;3730.694257010079;3753.9436908446396;3782.867599634;3814.5231846019246;7944.563049032358;7982.640781164861;8003.719869804645;8038.115807261197;8038.356931445471;4097.774622395737;4130.91738165241;4133.111381053088;4138.461999940048;4162.666986641061;3071.0633256856872;3160.762942779301;3766.453864189677;3767.7550959188115;3767.962320376761;3253.4143854106014;3324.135724711544;3351.162209447638;3352.396568617672;3356.5300857879915;1025.2464438637596;1028.0285130551556;1030.1861529391697;1031.9174466042698;1036.3108532825738;898.3980732908967;989.569537251298;1097.1058587251364;1102.7463683352873;1103.051375816797;6448.516361272923;6514.3811337922825;6517.055027021055;6520;6522.804315870531;940.6049459227141;945.8344789661919;1010.0909181736349;1034.0280136671504;1034.7516596017051;5030;5030.572401345853;5043.697378157322;5060.51925067118;5084.44071152173;8152.307053900367;8410.243078122998;8411.579421028924;8417.831643367099;8427.915720842835;8094;8152.429329946846;8279.089300176976;8284.295834853985;8291;6522.869542609121;6573.539852210395;6573.934260657428;6577.802665919934;6581.769638062645;6287.993920972623;6308.589941653778;6355.300916899045;6366.745330186741;6387.393197646216;7406.666699998621;7438.516496427715;7477.027986361955;7496.887546686695;7509.88735168962;7571.697132114874;7612.80967975805;7639.770806875803;7708.730194443167;7732.806679833049;5280.419153892992;5369.436209197978;6090.056041313604;6136.20229370179;6139.631622102509;6358.586691865014;6418.133551970424;6459.289478157493;6473.579217351045;6474.967625161844;5984.730687119177;6133.447989680772;6142.723577438936;6148.78479253224;6288.496920246278;5844;5887.882242355215;5911.645301281937;5940.435658612425;5968.46283834457;6010;6156.445919867234;6191.628502289877;6208.317085120543;6235.906461402992;5486.945130548644;5494.725263736877;5502.724863756716;5505.119180931032;5528.55771538284;5625.184348269396;5708.343540492897;5712.628679136009;5749.7125143741805;5788.507976822018 19:00:06 INFO - PROCESS | 6363 | |4;prototype.html;303.09828260923746;307.403636944328;309.9101260634416;312.41734165780827;315.48575821411094;5357.8392648220515;5401.243825864377;5418.322709661293;5442.210879422481;5459.426760190177;5092.363454568179;5152.40747314059;5248.5538729208065;5345.625806193568;5362.2224777407255;4171.165766846628;4181.728187667807;4189.97905010476;4195.265828480012;4197.307444271692;3972.7616343019367;4187.1625674865145;4188.81150348235;4190.51809041961;4191.497020357561;4012.097278112416;4039.8182081806244;4131.091159944807;4131.21506913687;4137.958620413802;4091.85678501254;4116.9794151029355;4119.258533463975;4120.814563344627;4129.380592911058;3629.9274014519824;3630.3283892479712;3637.5998640149564;3639.5450568678916;3643.1074386775144;5179.922301165486;5212.322398088262;5218.086834803894;5218.817341393033;5233.031889100491;4560.8859778505475;4705.811767529295;4738.763061846894;4754.524547545252;4810.759462026885;5643.971780141114;5659.320881494205;5660.433956604348;5664.235328230719;5667.376588575295;3898.6549640374024;3903.668188204006;3903.9609603904164;3905.628965248297;3907.589703081164;5895.4399332063385;5987.37132601075;5992.101184822268;5997.7001149942325;6000.18997435345;3873.8063096845044;3981.2634662587516;3992.4210989406374;4025.2150830587752;4031.1937612477623;4090.0388408723925;4092.4475195848777;4092.590740925943;4092.7544347338658;4094.877153685394;4666.906661866811;4698.224792909132;4703.670743047954;4715.3869996900185;4716.339712440261;5678.716064196774;5686.687232202268;5688;5688.033034384164;5689.061304884648;1413.4487549855564;1418.4609848257803;1448.3120517754194;1448.3989144505124;1452.6876721504927;948.805494873563;973.6056896956744;974.201155052864;988.253868329421;988.7182153086336;4971.45314015458;4978.850634480971;4982.128127577659;4990.3762029746285;4991.625628077909;5864.44287792659;5880.206172166702;5893.116032595145;5897.469227769521;5898.911516327258;4771.71369717818;4830.130576496194;4860.781264843091;4944.1100601891285;4953.554180123734;3126.140311414379;3145.716885480272;3160.4627213373783;3162.6679198683805;3163.984180079085;5535.612507124543;5602.075657516464;5605.047141985872;5606;5606.439356064361;5905.911411328833;6087.452129308295;6099.359567245464;6105.145279660851;6107.84730381744;5570.832875013756;5580.553555715533;5624.971875140598;5626.831195064155;5649.632773869603;5960.135780311917;5974.133750606225;5974.701264936649;5977.6114552553945;5981.850453738692;5818.127280907897;5826.038703613856;5827.59206855516;5831.533477321889;5832;5514.503694667499;5547.44525547442;5622.6064175508955;5623.775048997994;5629.437056294501;4131.97934010328;4170.6871984601885;4174.603412675791;4175.018870565354;4177.12280421115;5841.561882858718;5874.471297583238;5887.293524777054;5887.882242355215;5892.793752218652;5514.503694667499;5640;5645.830625081254;5651.378348381757;5654.3497497788285;5570.080936645408;5627.634203776742;5630.774769009357;5633.746481408264;5636.915446268227;5496.532794712494;5519.144532597454;5534.225208470898;5577.107662773937;5581.330240371181;5684.431556844283;5685.118806584986;5685.971570142123;5690.032694442038;5691;5381.3004309441085;5543.445655434424;5569.443055694398;5588.077967135378;5611.438856114356 19:00:06 INFO - PROCESS | 6363 | |5;yui.html;599.6731781179257;618.3260246331498;675.0785178231714;689.3072462175513;690.2476300832092;11149.554017839288;11332.263402878807;11334.773304533905;11337.773244535105;11337.773244535114;10542.367457952529;10652.78694426113;10654.25420220583;10671.679849604525;10673.092787113104;621.363102819609;625.9436650701437;762.9580373079478;768.0514564512822;778.6145857800368;777.7783331750452;779.5673401262297;786.001777742267;786.1391776005265;787.4527203593505;781.847539729753;786.6695987685157;787.5943888897223;787.5983248543256;788.5662885413028;641.1184621145925;650.0703993289594;797.0753925446484;813.4346629092782;814.8940637717118;605.2192671453819;605.4853374631572;605.5186127028978;605.7032054293409;605.7667797897797;10670.093042091432;10802.621908233174;10811.243212975094;10818.188635852342;10821.404822734747;10291.948540257326;11184.44077796107;11459.312441253469;11483.42582870853;11601.303921764636;9021.503817290046;9027.4132181408;9124.95437522808;9203;9270.351075424724;2759.7240275972445;2786.7909906757072;2807.7894157938235;2816.830990140578;2869.6126022986837;37186.44220336697;37300.62699373026;37463.625363746556;37674.623253767386;37719.86840394765;9033.322500812465;9113.635454581743;9189.724308270763;9280.071992800666;9500.619975200914;15535.766963495556;15539.611509712122;15548.300326485336;15564.287928327874;15586;6156.938430615636;6170.938290617037;6260.436560709558;6364.363563643598;6462.386073323027;3459.135216195951;3507.31607336572;3526.3123690880543;3543.2542463873647;3565.928681426357;2632.4998250332374;2656.973430265711;2658.41514866729;2659.654244948183;2673.9866300668373;471.4036743519451;475.11628371229483;478.0200588792961;486.545080349874;489.13911515731854;498.9825356112519;533.8345113014977;557.5233175634855;604.3261763134074;627.159606127791;7281.271872812782;7297.781066567905;7529.247075292427;7633.694652213961;7744.6902123914415;400.49737579338324;421.52578349356975;445.625674433471;451.63868904875966;607.0984587886984;3636.381815091441;3653.214558869856;3723.236736469017;3729.1236559408517;4200.7479551227025;43586.56413435889;43779;43866.342004869955;47563.5243647566;48782.26826597604;38537.421938670945;38597.6140238594;38638.420423693664;39147.60852391497;39324.60675393267;38362;39663.20673586512;39783.40324895129;41234.1753164935;41304.58695413007;7356.154042284991;7361.374283185989;7379.852402952019;7508.887366689613;7524.134724506752;31593.8420307897;32375.19062023374;32384.514232286063;32486.35027299488;32552.186195345304;36726.816365918;39300.606993930836;40135.3979690299;40697.59302406938;40792.3881141789;9566.521673916415;9885.357451765612;10062.748431289276;10136.898631013595;10234.33476824004;10903;11262;11268.661940141808;11291.378974156172;11350.205485616258;10008.299419040597;10403.271770975958;10419.583216671552;10626.415547144981;10823.188260880308;9718.319717619699;10124.746881328027;10150.939624150398;10257.28199026061;10444.009498166837;10204.948975255076;10291.320949586168;10333.896661033294;10449.895501045195;10484.63303784364;9127;9171.587278572346;9178.357514973888;9251.583678734338;9482.288828337765;8536.189062039097;8570.4000719949;9018.278537717099;9228.95385523068;9441.763955901157 19:00:06 INFO - PROCESS | 6363 | __end_tp_report 19:00:06 INFO - PROCESS | 6363 | __start_cc_report 19:00:06 INFO - PROCESS | 6363 | _x_x_mozilla_cycle_collect,812 19:00:06 INFO - PROCESS | 6363 | __end_cc_report 19:00:06 INFO - PROCESS | 6363 | __startTimestamp1451098806967__endTimestamp 19:00:06 INFO - PROCESS | 6363 | 19:00:06 INFO - PROCESS | 6363 | ------- Summary: start ------- 19:00:06 INFO - PROCESS | 6363 | Number of tests: 6 19:00:06 INFO - PROCESS | 6363 | 19:00:06 INFO - PROCESS | 6363 | [#0] dojo.html Cycles:165 Average:4496.64 Median:4646.42 stddev:451.66 (9.7%) stddev-sans-first:427.24 19:00:06 INFO - PROCESS | 6363 | Values: 2578.2 2660.6 2663.0 2675.6 2688.8 4366.5 4487.7 4513.5 4526.6 4547.9 4514.8 4543.7 4576.2 4599.5 4650.2 4160.0 4206.1 4235.2 4283.0 4310.6 4042.1 4234.9 4297.4 4312.5 4348.8 4110.6 4117.4 4187.2 4272.0 4293.2 4179.6 4183.4 4192.7 4206.3 4225.5 4168.5 4178.3 4191.5 4206.2 4217.5 4278.1 4398.4 4402.3 4478.5 4578.9 4872.0 4881.8 4885.6 4888.4 4911.7 4887.2 4908.4 4908.9 4934.0 4946.2 4366.5 4460.2 4463.5 4476.7 4606.8 4993.6 5001.4 5003.1 5015.8 5027.9 4814.1 4826.6 4827.3 4828.4 4876.9 4675.8 4743.0 4778.8 4779.9 4898.1 4820.3 4825.9 4841.2 4850.8 4884.8 4822.0 4823.3 4829.9 4830.2 4878.4 3950.3 4021.7 4041.5 4042.7 4110.2 3628.1 3633.6 3640.3 3648.9 3651.0 4234.1 4236.2 4240.8 4242.2 4278.7 4611.2 4770.7 4782.0 4838.7 4894.1 4261.4 4266.6 4271.1 4288.3 4292.5 4393.0 4399.4 4408.1 4410.0 4447.9 4479.6 4596.0 4681.6 4682.8 4727.9 4730.1 4865.7 4933.8 4960.8 4963.9 4667.9 4688.6 4690.6 4691.4 4728.2 4683.3 4832.6 4836.5 4839.4 4892.3 4746.1 4762.9 4766.5 4776.8 4874.9 4720.2 4736.4 4738.9 4747.1 4785.8 4714.3 4734.6 4735.6 4738.0 4769.4 4372.3 4392.3 4481.4 4518.4 4618.1 4746.1 4747.7 4756.6 4758.4 4783.6 4646.4 4648.5 4648.6 4692.8 4694.2 19:00:06 INFO - PROCESS | 6363 | 19:00:06 INFO - PROCESS | 6363 | [#1] ext.html Cycles:180 Average:39760.00 Median:18512.97 stddev:64162.33 (346.6%) stddev-sans-first:64274.71 19:00:06 INFO - PROCESS | 6363 | Values: 530.6 562.7 572.3 572.8 588.0 24928.5 25367.4 32913.5 33060.2 33145.8 37942.2 38919.0 38926.0 38965.2 38996.4 6691.2 7460.2 7603.2 7603.6 7605.8 6940.1 9750.8 9985.5 9989.9 9993.2 9562.0 9588.0 9665.0 9667.8 9669.2 9629.8 9759.5 9766.7 9781.5 9786.6 9471.1 9623.2 9624.0 9627.8 9855.3 35970.3 36442.3 36486.0 36500.0 36523.1 2779.7 2882.8 2908.8 2955.8 3380.2 27575.4 27900.4 28033.4 28113.4 28260.0 3327.3 3344.2 3365.1 3382.1 3392.7 220225.0 220740.0 221255.0 221428.0 221694.9 43888.8 44664.8 45022.8 51498.0 52167.0 54350.7 55443.7 55590.0 55601.4 55749.7 12485.8 12848.0 12879.8 12883.4 12907.2 9201.9 9260.2 9269.9 9272.5 9276.0 15275.3 15381.3 15386.8 15925.4 16005.2 7051.0 7234.5 7249.0 7271.1 7334.9 841.6 890.4 891.2 906.7 1040.2 26049.3 26062.3 26193.4 26287.5 26402.2 925.7 936.3 953.7 1000.5 1015.8 13388.4 13480.3 13603.4 13746.8 13783.4 265270.0 271009.6 271367.0 271458.0 271697.0 44200.3 44507.8 44521.8 44528.6 44591.8 1037.3 1146.2 1148.9 1151.2 1251.9 23115.2 23688.2 24402.1 24759.0 25840.4 36396.0 36683.6 36717.0 36731.3 36762.0 226742.0 231689.6 250335.0 257756.0 257861.0 25625.4 25699.0 25840.2 25849.2 25873.9 33660.8 36832.3 38511.4 38856.0 39251.8 31402.2 31697.4 31919.7 32242.7 32371.4 30334.8 33902.0 34498.3 34865.3 34981.5 31888.0 32091.8 32239.7 32741.5 32913.0 25185.2 25919.6 29753.9 30559.5 30661.0 22427.3 23065.9 24516.3 24927.3 24996.6 19:00:06 INFO - PROCESS | 6363 | 19:00:06 INFO - PROCESS | 6363 | [#2] jquery.html Cycles:180 Average:27543.56 Median:17155.77 stddev:82443.21 (480.6%) stddev-sans-first:82649.17 19:00:06 INFO - PROCESS | 6363 | Values: 334.1 336.7 336.9 337.8 340.5 12196.5 12545.0 14621.6 14974.3 16467.0 8396.5 9815.1 10070.8 13752.4 15514.5 4412.2 4537.1 4541.9 4542.5 4543.3 3334.2 3428.6 4503.9 5046.7 5206.0 5172.1 5174.7 5180.4 5185.7 5196.3 5083.5 5163.9 5223.4 5226.6 5229.5 5053.3 5061.5 5065.4 5068.6 5070.2 11102.6 18859.3 18941.9 19120.6 20089.2 1887.4 1913.2 1915.5 1923.5 1958.2 12908.1 12934.2 13116.7 13285.1 13463.6 1806.2 1807.0 1838.6 1855.3 1894.7 48329.0 63530.4 63729.0 63803.4 64111.4 15140.8 15250.9 15314.8 15343.6 15369.0 22987.2 23013.7 23205.5 23256.4 23313.8 7730.1 7783.4 7900.6 7939.0 8007.2 6353.6 6380.2 6384.8 6394.6 6399.3 7402.6 7464.3 7480.6 7483.6 7492.0 2325.5 2859.4 2989.2 3059.4 3063.5 714.9 726.2 761.9 846.1 853.2 14411.9 15879.4 16578.0 16605.7 17110.2 741.4 851.1 856.1 863.2 889.7 8918.2 9063.6 9165.0 9228.4 9324.7 471918.0 476683.1 508416.0 521662.0 542509.0 69887.7 71596.3 72762.0 73673.0 73703.0 1024.9 1029.7 1037.5 1038.0 1039.6 14053.4 14131.2 14291.4 14301.1 14317.4 33461.3 33648.3 33764.5 33971.0 35157.3 43384.8 44218.0 44430.0 44825.3 47947.3 8474.2 8705.8 8950.2 8954.3 8955.1 15367.0 15403.5 15433.6 15524.8 15856.4 12911.8 13222.9 13298.8 13547.9 13673.9 12633.8 12694.2 13082.6 13127.5 13136.1 12957.4 13331.9 13614.7 13752.2 13884.9 8763.0 8854.6 8888.1 8893.7 8907.2 9548.8 12661.3 13105.3 13229.9 13719.5 19:00:06 INFO - PROCESS | 6363 | 19:00:06 INFO - PROCESS | 6363 | [#3] mootools.html Cycles:180 Average:4787.78 Median:5899.76 stddev:2508.09 (42.5%) stddev-sans-first:2499.76 19:00:06 INFO - PROCESS | 6363 | Values: 1094.6 1366.5 1374.8 1484.2 1686.8 5745.1 6805.3 6876.4 6882.8 6902.2 6683.8 6796.5 6805.3 6819.0 6824.1 1842.1 1878.2 1882.6 1885.0 1885.1 1916.9 1933.8 1938.2 1991.9 2007.5 1937.5 1952.6 1955.4 1955.5 1955.7 1905.3 1936.1 1942.1 1942.6 1943.2 1905.8 1909.4 1920.8 1980.8 1993.6 7095.1 7157.3 7182.0 7182.1 7186.2 4077.9 4138.3 4159.8 4172.7 4176.2 2600.2 2655.6 2687.5 2710.6 2713.4 799.5 800.1 808.4 814.5 829.8 9418.3 9432.5 9458.3 9476.1 9502.1 3710.1 3730.7 3753.9 3782.9 3814.5 7944.6 7982.6 8003.7 8038.1 8038.4 4097.8 4130.9 4133.1 4138.5 4162.7 3071.1 3160.8 3766.5 3767.8 3768.0 3253.4 3324.1 3351.2 3352.4 3356.5 1025.2 1028.0 1030.2 1031.9 1036.3 898.4 989.6 1097.1 1102.7 1103.1 6448.5 6514.4 6517.1 6520.0 6522.8 940.6 945.8 1010.1 1034.0 1034.8 5030.0 5030.6 5043.7 5060.5 5084.4 8152.3 8410.2 8411.6 8417.8 8427.9 8094.0 8152.4 8279.1 8284.3 8291.0 6522.9 6573.5 6573.9 6577.8 6581.8 6288.0 6308.6 6355.3 6366.7 6387.4 7406.7 7438.5 7477.0 7496.9 7509.9 7571.7 7612.8 7639.8 7708.7 7732.8 5280.4 5369.4 6090.1 6136.2 6139.6 6358.6 6418.1 6459.3 6473.6 6475.0 5984.7 6133.4 6142.7 6148.8 6288.5 5844.0 5887.9 5911.6 5940.4 5968.5 6010.0 6156.4 6191.6 6208.3 6235.9 5486.9 5494.7 5502.7 5505.1 5528.6 5625.2 5708.3 5712.6 5749.7 5788.5 19:00:06 INFO - PROCESS | 6363 | 19:00:06 INFO - PROCESS | 6363 | [#4] prototype.html Cycles:180 Average:4696.44 Median:5371.76 stddev:1390.40 (25.9%) stddev-sans-first:1354.63 19:00:06 INFO - PROCESS | 6363 | Values: 303.1 307.4 309.9 312.4 315.5 5357.8 5401.2 5418.3 5442.2 5459.4 5092.4 5152.4 5248.6 5345.6 5362.2 4171.2 4181.7 4190.0 4195.3 4197.3 3972.8 4187.2 4188.8 4190.5 4191.5 4012.1 4039.8 4131.1 4131.2 4138.0 4091.9 4117.0 4119.3 4120.8 4129.4 3629.9 3630.3 3637.6 3639.5 3643.1 5179.9 5212.3 5218.1 5218.8 5233.0 4560.9 4705.8 4738.8 4754.5 4810.8 5644.0 5659.3 5660.4 5664.2 5667.4 3898.7 3903.7 3904.0 3905.6 3907.6 5895.4 5987.4 5992.1 5997.7 6000.2 3873.8 3981.3 3992.4 4025.2 4031.2 4090.0 4092.4 4092.6 4092.8 4094.9 4666.9 4698.2 4703.7 4715.4 4716.3 5678.7 5686.7 5688.0 5688.0 5689.1 1413.4 1418.5 1448.3 1448.4 1452.7 948.8 973.6 974.2 988.3 988.7 4971.5 4978.9 4982.1 4990.4 4991.6 5864.4 5880.2 5893.1 5897.5 5898.9 4771.7 4830.1 4860.8 4944.1 4953.6 3126.1 3145.7 3160.5 3162.7 3164.0 5535.6 5602.1 5605.0 5606.0 5606.4 5905.9 6087.5 6099.4 6105.1 6107.8 5570.8 5580.6 5625.0 5626.8 5649.6 5960.1 5974.1 5974.7 5977.6 5981.9 5818.1 5826.0 5827.6 5831.5 5832.0 5514.5 5547.4 5622.6 5623.8 5629.4 4132.0 4170.7 4174.6 4175.0 4177.1 5841.6 5874.5 5887.3 5887.9 5892.8 5514.5 5640.0 5645.8 5651.4 5654.3 5570.1 5627.6 5630.8 5633.7 5636.9 5496.5 5519.1 5534.2 5577.1 5581.3 5684.4 5685.1 5686.0 5690.0 5691.0 5381.3 5543.4 5569.4 5588.1 5611.4 19:00:06 INFO - PROCESS | 6363 | 19:00:06 INFO - PROCESS | 6363 | [#5] yui.html Cycles:180 Average:11712.83 Median:41269.38 stddev:13016.12 (31.5%) stddev-sans-first:13025.88 19:00:06 INFO - PROCESS | 6363 | Values: 599.7 618.3 675.1 689.3 690.2 11149.6 11332.3 11334.8 11337.8 11337.8 10542.4 10652.8 10654.3 10671.7 10673.1 621.4 625.9 763.0 768.1 778.6 777.8 779.6 786.0 786.1 787.5 781.8 786.7 787.6 787.6 788.6 641.1 650.1 797.1 813.4 814.9 605.2 605.5 605.5 605.7 605.8 10670.1 10802.6 10811.2 10818.2 10821.4 10291.9 11184.4 11459.3 11483.4 11601.3 9021.5 9027.4 9125.0 9203.0 9270.4 2759.7 2786.8 2807.8 2816.8 2869.6 37186.4 37300.6 37463.6 37674.6 37719.9 9033.3 9113.6 9189.7 9280.1 9500.6 15535.8 15539.6 15548.3 15564.3 15586.0 6156.9 6170.9 6260.4 6364.4 6462.4 3459.1 3507.3 3526.3 3543.3 3565.9 2632.5 2657.0 2658.4 2659.7 2674.0 471.4 475.1 478.0 486.5 489.1 499.0 533.8 557.5 604.3 627.2 7281.3 7297.8 7529.2 7633.7 7744.7 400.5 421.5 445.6 451.6 607.1 3636.4 3653.2 3723.2 3729.1 4200.7 43586.6 43779.0 43866.3 47563.5 48782.3 38537.4 38597.6 38638.4 39147.6 39324.6 38362.0 39663.2 39783.4 41234.2 41304.6 7356.2 7361.4 7379.9 7508.9 7524.1 31593.8 32375.2 32384.5 32486.4 32552.2 36726.8 39300.6 40135.4 40697.6 40792.4 9566.5 9885.4 10062.7 10136.9 10234.3 10903.0 11262.0 11268.7 11291.4 11350.2 10008.3 10403.3 10419.6 10626.4 10823.2 9718.3 10124.7 10150.9 10257.3 10444.0 10204.9 10291.3 10333.9 10449.9 10484.6 9127.0 9171.6 9178.4 9251.6 9482.3 8536.2 8570.4 9018.3 9229.0 9441.8 19:00:06 INFO - PROCESS | 6363 | -------- Summary: end -------- 19:00:06 INFO - PROCESS | 6363 | 19:00:07 INFO - TEST-INFO | 6363: exit 0 19:00:07 INFO - TEST-OK | dromaeo_css | took 1116477ms 19:00:07 INFO - TEST-START | kraken 19:00:07 INFO - operating with platform_type : linux_ 19:00:07 INFO - Initialising browser for kraken test... 19:00:07 INFO - TEST-INFO | started process 6554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2DEGXN/profile http://localhost:36683/getInfo.html) 19:00:12 INFO - PROCESS | 6554 | __metrics Screen width/height:1600/1200 19:00:12 INFO - PROCESS | 6554 | colorDepth:24 19:00:12 INFO - PROCESS | 6554 | Browser inner width/height: 1024/697 19:00:12 INFO - PROCESS | 6554 | __metrics 19:00:12 INFO - PROCESS | 6554 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:00:12 INFO - PROCESS | 6554 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:00:12 ERROR - PROCESS | 6554 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 19:00:13 INFO - TEST-INFO | 6554: exit 0 19:00:13 INFO - Browser initialized. 19:00:13 INFO - Running cycle 1/1 for kraken test... 19:00:13 INFO - TEST-INFO | started process 6635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2DEGXN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:24 INFO - PROCESS | 6635 | RSS: Main: 151023616 19:00:24 INFO - PROCESS | 6635 | 19:00:27 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36683/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:28 INFO - PROCESS | 6635 | RSS: Main: 186658816 19:00:28 INFO - PROCESS | 6635 | 19:00:30 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36683/tests/kraken/driver.html?testName=audio-dft) 19:00:31 INFO - PROCESS | 6635 | RSS: Main: 178368512 19:00:31 INFO - PROCESS | 6635 | 19:00:34 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36683/tests/kraken/driver.html?testName=audio-fft) 19:00:35 INFO - PROCESS | 6635 | RSS: Main: 161550336 19:00:35 INFO - PROCESS | 6635 | 19:00:37 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36683/tests/kraken/driver.html?testName=audio-oscillator) 19:00:37 INFO - PROCESS | 6635 | RSS: Main: 163598336 19:00:37 INFO - PROCESS | 6635 | 19:00:39 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:00:40 INFO - PROCESS | 6635 | RSS: Main: 166346752 19:00:40 INFO - PROCESS | 6635 | 19:00:43 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36683/tests/kraken/driver.html?testName=imaging-darkroom) 19:00:43 INFO - PROCESS | 6635 | RSS: Main: 165441536 19:00:43 INFO - PROCESS | 6635 | 19:00:47 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36683/tests/kraken/driver.html?testName=imaging-desaturate) 19:00:47 INFO - PROCESS | 6635 | RSS: Main: 165384192 19:00:47 INFO - PROCESS | 6635 | 19:00:50 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36683/tests/kraken/driver.html?testName=json-parse-financial) 19:00:51 INFO - PROCESS | 6635 | RSS: Main: 167251968 19:00:51 INFO - PROCESS | 6635 | 19:00:53 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:00:53 INFO - PROCESS | 6635 | RSS: Main: 177758208 19:00:53 INFO - PROCESS | 6635 | 19:00:55 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36683/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:00:56 INFO - PROCESS | 6635 | RSS: Main: 179175424 19:00:56 INFO - PROCESS | 6635 | 19:00:58 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:00:58 INFO - PROCESS | 6635 | RSS: Main: 187133952 19:00:58 INFO - PROCESS | 6635 | 19:01:01 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:01:02 INFO - PROCESS | 6635 | RSS: Main: 191287296 19:01:02 INFO - PROCESS | 6635 | 19:01:04 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:05 INFO - PROCESS | 6635 | RSS: Main: 190509056 19:01:05 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:36683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36683/tests/kraken/driver.html?testName=ai-astar) 19:01:07 INFO - PROCESS | 6635 | RSS: Main: 248578048 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | __start_tp_report 19:01:07 INFO - PROCESS | 6635 | _x_x_mozilla_page_load 19:01:07 INFO - PROCESS | 6635 | _x_x_mozilla_page_load_details 19:01:07 INFO - PROCESS | 6635 | |i|pagename|runs| 19:01:07 INFO - PROCESS | 6635 | |0;ai-astar;112;113;108;112;111;113;103;114;111;103 19:01:07 INFO - PROCESS | 6635 | |1;audio-beat-detection;154;128;154;166;131;149;161;140;168;133 19:01:07 INFO - PROCESS | 6635 | |2;audio-dft;161;161;159;159;162;161;163;161;161;162 19:01:07 INFO - PROCESS | 6635 | |3;audio-fft;75;71;82;95;72;72;72;116;89;72 19:01:07 INFO - PROCESS | 6635 | |4;audio-oscillator;97;96;133;97;97;96;134;98;98;129 19:01:07 INFO - PROCESS | 6635 | |5;imaging-gaussian-blur;110;109;109;109;110;110;110;109;110;110 19:01:07 INFO - PROCESS | 6635 | |6;imaging-darkroom;147;147;147;147;146;147;147;147;147;147 19:01:07 INFO - PROCESS | 6635 | |7;imaging-desaturate;95;96;95;95;96;96;95;96;95;95 19:01:07 INFO - PROCESS | 6635 | |8;json-parse-financial;71;72;71;71;71;72;71;80;69;68 19:01:07 INFO - PROCESS | 6635 | |9;json-stringify-tinderbox;67;68;68;68;67;68;67;68;67;68 19:01:07 INFO - PROCESS | 6635 | |10;stanford-crypto-aes;85;85;84;83;90;85;84;86;86;86 19:01:07 INFO - PROCESS | 6635 | |11;stanford-crypto-ccm;124;129;119;118;119;135;128;136;128;120 19:01:07 INFO - PROCESS | 6635 | |12;stanford-crypto-pbkdf2;137;163;139;148;148;139;151;154;140;137 19:01:07 INFO - PROCESS | 6635 | |13;stanford-crypto-sha256-iterative;69;71;73;70;69;68;69;71;69;70 19:01:07 INFO - PROCESS | 6635 | __end_tp_report 19:01:07 INFO - PROCESS | 6635 | __start_cc_report 19:01:07 INFO - PROCESS | 6635 | _x_x_mozilla_cycle_collect,987 19:01:07 INFO - PROCESS | 6635 | __end_cc_report 19:01:07 INFO - PROCESS | 6635 | __startTimestamp1451098867292__endTimestamp 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | ------- Summary: start ------- 19:01:07 INFO - PROCESS | 6635 | Number of tests: 14 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:4.03 (3.6%) stddev-sans-first:4.21 19:01:07 INFO - PROCESS | 6635 | Values: 112.0 113.0 108.0 112.0 111.0 113.0 103.0 114.0 111.0 103.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:154.00 stddev:14.69 (9.5%) stddev-sans-first:15.44 19:01:07 INFO - PROCESS | 6635 | Values: 154.0 128.0 154.0 166.0 131.0 149.0 161.0 140.0 168.0 133.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 19:01:07 INFO - PROCESS | 6635 | Values: 161.0 161.0 159.0 159.0 162.0 161.0 163.0 161.0 161.0 162.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#3] audio-fft Cycles:10 Average:81.60 Median:73.50 stddev:14.69 (20.0%) stddev-sans-first:15.39 19:01:07 INFO - PROCESS | 6635 | Values: 75.0 71.0 82.0 95.0 72.0 72.0 72.0 116.0 89.0 72.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:97.00 stddev:16.97 (17.5%) stddev-sans-first:17.56 19:01:07 INFO - PROCESS | 6635 | Values: 97.0 96.0 133.0 97.0 97.0 96.0 134.0 98.0 98.0 129.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:01:07 INFO - PROCESS | 6635 | Values: 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 110.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 19:01:07 INFO - PROCESS | 6635 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:01:07 INFO - PROCESS | 6635 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:71.00 stddev:3.20 (4.5%) stddev-sans-first:3.39 19:01:07 INFO - PROCESS | 6635 | Values: 71.0 72.0 71.0 71.0 71.0 72.0 71.0 80.0 69.0 68.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 19:01:07 INFO - PROCESS | 6635 | Values: 67.0 68.0 68.0 68.0 67.0 68.0 67.0 68.0 67.0 68.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:1.90 (2.2%) stddev-sans-first:2.01 19:01:07 INFO - PROCESS | 6635 | Values: 85.0 85.0 84.0 83.0 90.0 85.0 84.0 86.0 86.0 86.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:128.00 stddev:6.65 (5.2%) stddev-sans-first:7.03 19:01:07 INFO - PROCESS | 6635 | Values: 124.0 129.0 119.0 118.0 119.0 135.0 128.0 136.0 128.0 120.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:148.00 stddev:8.69 (5.9%) stddev-sans-first:8.65 19:01:07 INFO - PROCESS | 6635 | Values: 137.0 163.0 139.0 148.0 148.0 139.0 151.0 154.0 140.0 137.0 19:01:07 INFO - PROCESS | 6635 | 19:01:07 INFO - PROCESS | 6635 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.45 (2.1%) stddev-sans-first:1.50 19:01:07 INFO - PROCESS | 6635 | Values: 69.0 71.0 73.0 70.0 69.0 68.0 69.0 71.0 69.0 70.0 19:01:07 INFO - PROCESS | 6635 | -------- Summary: end -------- 19:01:07 INFO - PROCESS | 6635 | 19:01:08 INFO - TEST-INFO | 6635: exit 0 19:01:08 INFO - TEST-OK | kraken | took 60452ms 19:01:08 INFO - TEST-START | v8_7 19:01:08 INFO - operating with platform_type : linux_ 19:01:08 INFO - Initialising browser for v8_7 test... 19:01:08 INFO - TEST-INFO | started process 6884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU2Nsuh/profile http://localhost:36683/getInfo.html) 19:01:12 INFO - PROCESS | 6884 | __metrics Screen width/height:1600/1200 19:01:12 INFO - PROCESS | 6884 | colorDepth:24 19:01:12 INFO - PROCESS | 6884 | Browser inner width/height: 1024/697 19:01:12 INFO - PROCESS | 6884 | __metrics 19:01:12 INFO - PROCESS | 6884 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:01:12 INFO - PROCESS | 6884 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:01:13 INFO - TEST-INFO | 6884: exit 0 19:01:13 INFO - Browser initialized. 19:01:13 INFO - Running cycle 1/1 for v8_7 test... 19:01:13 INFO - TEST-INFO | started process 6970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU2Nsuh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:25 INFO - PROCESS | 6970 | RSS: Main: 151846912 19:01:25 INFO - PROCESS | 6970 | 19:01:46 INFO - PROCESS | 6970 | Cycle 1(1): loaded http://localhost:36683/tests/v8_7/run.html (next: http://localhost:36683/tests/v8_7/run.html) 19:01:47 INFO - PROCESS | 6970 | RSS: Main: 450576384 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | __start_tp_report 19:01:47 INFO - PROCESS | 6970 | _x_x_mozilla_page_load 19:01:47 INFO - PROCESS | 6970 | _x_x_mozilla_page_load_details 19:01:47 INFO - PROCESS | 6970 | |i|pagename|runs| 19:01:47 INFO - PROCESS | 6970 | |0;Richards;166.27868307283006 19:01:47 INFO - PROCESS | 6970 | |1;DeltaBlue;189.17896329928112 19:01:47 INFO - PROCESS | 6970 | |2;Encrypt;279.56388034665923 19:01:47 INFO - PROCESS | 6970 | |3;Decrypt;5191.709844559586 19:01:47 INFO - PROCESS | 6970 | |4;RayTrace;2004.0080160320642 19:01:47 INFO - PROCESS | 6970 | |5;Earley;809.7165991902834 19:01:47 INFO - PROCESS | 6970 | |6;Boyer;12600 19:01:47 INFO - PROCESS | 6970 | |7;RegExp;27108.108108108107 19:01:47 INFO - PROCESS | 6970 | |8;Splay;615.0061500615006 19:01:47 INFO - PROCESS | 6970 | |9;NavierStokes;4845.410628019324 19:01:47 INFO - PROCESS | 6970 | __end_tp_report 19:01:47 INFO - PROCESS | 6970 | __startTimestamp1451098907133__endTimestamp 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | ------- Summary: start ------- 19:01:47 INFO - PROCESS | 6970 | Number of tests: 10 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 166.3 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#1] DeltaBlue Cycles:1 Average:189.18 Median:189.18 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 189.2 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 279.6 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 5191.7 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#4] RayTrace Cycles:1 Average:2004.01 Median:2004.01 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 2004.0 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#5] Earley Cycles:1 Average:809.72 Median:809.72 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 809.7 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#6] Boyer Cycles:1 Average:12600.00 Median:12600.00 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 12600.0 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 27108.1 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#8] Splay Cycles:1 Average:615.01 Median:615.01 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 615.0 19:01:47 INFO - PROCESS | 6970 | 19:01:47 INFO - PROCESS | 6970 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 19:01:47 INFO - PROCESS | 6970 | Values: 4845.4 19:01:47 INFO - PROCESS | 6970 | -------- Summary: end -------- 19:01:47 INFO - PROCESS | 6970 | 19:01:48 INFO - TEST-INFO | 6970: exit 0 19:01:48 INFO - TEST-OK | v8_7 | took 39874ms 19:01:48 INFO - SUITE-END | took 1216s 19:01:48 INFO - Completed test suite (00:20:16) 19:01:48 INFO - Working with test: dromaeo_css 19:01:48 INFO - Generating results file: dromaeo_css 19:01:48 INFO - Working with test: kraken 19:01:48 INFO - Generating results file: kraken 19:01:48 INFO - javascript benchmark 19:01:48 INFO - Working with test: v8_7 19:01:48 INFO - Generating results file: v8_7 19:01:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:01:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 19:01:48 INFO - process_Request line: dromaeo_css 6235.50 graph.html#tests=[[72,94,35]] 19:01:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:01:48 INFO - process_Request line: kraken 1526.10 graph.html#tests=[[232,94,35]] 19:01:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:01:48 INFO - process_Request line: v8_7 19575.56 graph.html#tests=[[230,94,35]] 19:01:48 INFO - RETURN: dromaeo_css: 6235.50 19:01:48 INFO - RETURN: kraken: 1526.10 19:01:48 INFO - RETURN: v8_7: 19575.56 19:01:48 INFO - javascript benchmark 19:01:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2578.213644838324, 2660.6408134901794, 2663.041305130154, 2675.5986602009707, 2688.771454426373, 4366.519682834885, 4487.730736155825, 4513.548645135485, 4526.592606665404, 4547.863564093078, 4514.841980530682, 4543.659225558088, 4576.153411618853, 4599.494055653875, 4650.23271160259, 4159.958400415987, 4206.074663574024, 4235.216484950286, 4282.993496528329, 4310.612044915957, 4042.090529630839, 4234.894127646803, 4297.376880352347, 4312.504062032875, 4348.760818155, 4110.6300432961025, 4117.3618089196225, 4187.183499217654, 4272.017435989708, 4293.205756934977, 4179.644730197937, 4183.3515805049965, 4192.685548583838, 4206.305959516707, 4225.535191128974, 4168.520620128694, 4178.331466965301, 4191.517975432834, 4206.221848957953, 4217.451731274915, 4278.080212754242, 4398.406215160944, 4402.273624851896, 4478.484974227973, 4578.885527861797, 4871.951280487186, 4881.829135980259, 4885.584725298354, 4888.41339039314, 4911.680740751875, 4887.193613053842, 4908.386451693538, 4908.852734417973, 4934.0, 4946.183879659852, 4366.454193225815, 4460.219461594208, 4463.531329210451, 4476.7090139140855, 4606.769661516944, 4993.6005119590345, 5001.374828146481, 5003.124453220672, 5015.84952451427, 5027.924581131286, 4814.085323788469, 4826.61387089032, 4827.348307978448, 4828.444728856156, 4876.902461950741, 4675.836345727883, 4742.9762851186215, 4778.784954677048, 4779.928301075487, 4898.093852637274, 4820.276958456259, 4825.927611085836, 4841.249606310957, 4850.80596776125, 4884.780184891689, 4821.975890120527, 4823.324734537167, 4829.9275510867365, 4830.154722923475, 4878.365812444359, 3950.3481925482547, 4021.698372622065, 4041.474608300902, 4042.7372220805555, 4110.23960567296, 3628.092976755811, 3633.6003039665616, 3640.3265395901312, 3648.872289469856, 3651.032476393758, 4234.132002939452, 4236.216299984513, 4240.766757828349, 4242.193983143255, 4278.7432754034235, 4611.216093264153, 4770.6660533763, 4781.976090119597, 4838.7338696372035, 4894.143524883131, 4261.403403523509, 4266.637335826427, 4271.081717430705, 4288.31386978082, 4292.527821939584, 4393.0, 4399.36209249657, 4408.140412619508, 4409.977950110293, 4447.866564003085, 4479.619232365155, 4595.954040459686, 4681.648876334289, 4682.789274482725, 4727.881802954954, 4730.124926888537, 4865.70805751656, 4933.802647894044, 4960.77676504551, 4963.925541116959, 4667.8599642010795, 4688.6483513737285, 4690.554397332385, 4691.366665500251, 4728.219843725747, 4683.320918466735, 4832.589229915356, 4836.492168322276, 4839.419269687519, 4892.290617860462, 4746.145693775154, 4762.880927976828, 4766.523347665345, 4776.808927642855, 4874.8537543873745, 4720.150372932905, 4736.3842700450095, 4738.905221895474, 4747.145513807548, 4785.784639691292, 4714.3399924011355, 4734.573888350065, 4735.573798358164, 4737.952620473889, 4769.379980602499, 4372.278574035376, 4392.275274579659, 4481.395011673382, 4518.390017347616, 4618.0994706032, 4746.098241334135, 4747.715137091785, 4756.619470442287, 4758.428988521399, 4783.617310615073, 4646.4191976003, 4648.488666246642, 4648.628109751279, 4692.812287508462, 4694.225452800386], "unit": "score", "name": "dojo.html", "value": 4469.732763575984}, {"lowerIsBetter": false, "replicates": [530.5516838271659, 562.6680258647398, 572.2532095615222, 572.8281515545335, 587.985300367491, 24928.50142997139, 25367.365815854613, 32913.506297405525, 33060.17349566256, 33145.83427082867, 37942.24115517688, 38919.0, 38926.0, 38965.22069558614, 38996.41505377422, 6691.197056353244, 7460.216677248878, 7603.163651998276, 7603.619819009027, 7605.771826845204, 6940.097787287646, 9750.756231094208, 9985.500724963758, 9989.850152247722, 9993.200543956465, 9562.043795620451, 9588.0, 9665.0, 9667.758306042335, 9669.226461883032, 9629.807403851919, 9759.512024398822, 9766.658166964158, 9781.510924453749, 9786.5596048178, 9471.10024547667, 9623.230141588656, 9623.951880240624, 9627.807443851154, 9855.310128291023, 35970.28059438823, 36442.27115457676, 36486.0, 36500.0, 36523.08692282688, 2779.7498225159834, 2882.8126171798767, 2908.7527560157414, 2955.8374289414073, 3380.188754698879, 27575.448491030267, 27900.441991160267, 28033.439331213467, 28113.437731245464, 28260.0, 3327.317899830553, 3344.2308269098244, 3365.1082463147286, 3382.0530251529613, 3392.6607339266125, 220225.0, 220740.0, 221255.0, 221428.0, 221694.89152554295, 43888.780556097016, 44664.776676117064, 45022.77488612536, 51498.0, 52167.0, 54350.728246358514, 55443.72278138583, 55590.0, 55601.443985560436, 55749.72125139349, 12485.812712809315, 12848.036397270054, 12879.806802897963, 12883.355832208352, 12907.161034532724, 9201.907980920105, 9260.166585007248, 9269.860952085724, 9272.536373181314, 9276.0, 15275.312610932535, 15381.30784114695, 15386.846131538541, 15925.442609508844, 16005.237459831973, 7050.964745176344, 7234.529755565976, 7248.96375518119, 7271.091113610799, 7334.9266507335315, 841.6170642357713, 890.4479222881725, 891.2068259249273, 906.6600024990629, 1040.2250323508883, 26049.348766280615, 26062.34844128912, 26193.43054824846, 26287.474250515264, 26402.207933762016, 925.6621333213328, 936.2650319499161, 953.713885834247, 1000.4897502273893, 1015.8120747661707, 13388.397522111529, 13480.258585777876, 13603.387847546885, 13746.793798093036, 13783.448662053406, 265270.0, 271009.644951774, 271367.0, 271458.0, 271697.0, 44200.3369949451, 44507.777461112484, 44521.77739111284, 44528.55471445244, 44591.77704111459, 1037.305005646219, 1146.2377518949972, 1148.8965993060665, 1151.2459339132713, 1251.9170917156775, 23115.190968316027, 23688.170914017926, 24402.145924892542, 24759.0, 25840.353991150372, 36396.0, 36683.63316366802, 36717.0, 36731.26537469289, 36762.0, 226742.0, 231689.5739691684, 250335.0, 257756.0, 257861.0, 25625.359366015255, 25699.0, 25840.22479325623, 25849.22452326358, 25873.870630647478, 33660.83169584136, 36832.26335473329, 38511.422328665656, 38856.0, 39251.803740981115, 31402.21494462565, 31697.366052679277, 31919.68080319167, 32242.677573223966, 32371.35257294888, 30334.84832575823, 33902.0, 34498.31003379868, 34865.30269394648, 34981.47527787136, 31888.0, 32091.839540802146, 32239.677603224605, 32741.508877367334, 32913.0, 25185.24444266675, 25919.611205832305, 29753.851230744574, 30559.54160687547, 30661.0, 22427.32718018462, 23065.88467057654, 24516.264512064667, 24927.252182434557, 24996.625050624618], "unit": "score", "name": "ext.html", "value": 16520.409162416847}, {"lowerIsBetter": false, "replicates": [334.13125872730893, 336.66669996703257, 336.88377509759124, 337.7821305258109, 340.5368698569946, 12196.451159697812, 12545.0, 14621.561353159408, 14974.25128743564, 16466.999999999985, 8396.496210227391, 9815.067568580973, 10070.848937265928, 13752.381142848595, 15514.5345639631, 4412.227860124473, 4537.115262523809, 4541.931871021938, 4542.500324964251, 4543.250363689987, 3334.1831251343456, 3428.554287942564, 4503.864884053483, 5046.671966322196, 5206.0, 5172.12073947428, 5174.715390653512, 5180.378354597454, 5185.662931909433, 5196.272521846926, 5083.491650834905, 5163.870903227412, 5223.399309079467, 5226.634135610509, 5229.529342359206, 5053.343065401511, 5061.468545802674, 5065.392152941634, 5068.594512438996, 5070.163423035195, 11102.61140860066, 18859.33992310276, 18941.905290473598, 19120.617587648307, 20089.196432142697, 1887.3677318098453, 1913.2155816115326, 1915.4732448576613, 1923.4998900285887, 1958.177565422526, 12908.096433249677, 12934.159279646887, 13116.737665246641, 13285.13646612967, 13463.596092117252, 1806.2323512507132, 1807.0, 1838.6414649143424, 1855.2578968412608, 1894.6684330242153, 48329.04120443747, 63530.36469635291, 63729.04406433907, 63803.36196638067, 64111.358886411006, 15140.848591513944, 15250.923745381424, 15314.770278445832, 15343.616409589626, 15369.0, 22987.195448159233, 23013.698630136852, 23205.53588928212, 23256.4185895354, 23313.76686233116, 7730.072391313079, 7783.377329813601, 7900.604969751489, 7938.960305198437, 8007.199280071946, 6353.618782873043, 6380.170577824946, 6384.776532821329, 6394.5843520171975, 6399.328070552618, 7402.629868506553, 7464.253574642492, 7480.625968701544, 7483.550986940801, 7491.9625401872645, 2325.54651842889, 2859.352778262914, 2989.1929179121516, 3059.4034163337938, 3063.540468929634, 714.8677494663503, 726.2048057377164, 761.9409021460175, 846.0862268749859, 853.1724227499316, 14411.92794036023, 15879.444219452263, 16578.00531968086, 16605.6678866422, 17110.230039648246, 741.388354607451, 851.0808327006818, 856.1053698884681, 863.1713554987157, 889.6841621224502, 8918.19736223743, 9063.637454501877, 9165.0, 9228.446293222429, 9324.720258392259, 471918.0, 476683.08292292274, 508416.0, 521662.0, 542509.0, 69887.65056174686, 71596.28403716, 72762.0, 73673.0, 73703.0, 1024.882138554061, 1029.7477118106112, 1037.4605205293205, 1037.9896201038043, 1039.6361273554346, 14053.437862485385, 14131.15213087218, 14291.356888939814, 14301.070430421989, 14317.427302907767, 33461.330773384885, 33648.32703345968, 33764.493532597524, 33971.0, 35157.29685406329, 43384.783076084415, 44218.030565873196, 44430.0, 44825.32762008638, 47947.28079078747, 8474.237318641352, 8705.782355441164, 8950.194482496607, 8954.28365730727, 8955.149260820212, 15367.0, 15403.460878869633, 15433.614159646098, 15524.767128492857, 15856.365745370056, 12911.806322904977, 13222.933885330513, 13298.800517992431, 13547.86452135466, 13673.863261367656, 12633.81049284243, 12694.174878632859, 13082.607521774362, 13127.540536081191, 13136.080474366703, 12957.416916238602, 13331.866681333451, 13614.659633509242, 13752.174869507862, 13884.86115138876, 8763.0, 8854.601542930455, 8888.11118888132, 8893.73318800437, 8907.198352148338, 9548.809023819624, 12661.303628300531, 13105.344732763515, 13229.933850330686, 13719.519816806363], "unit": "score", "name": "jquery.html", "value": 8734.571380392472}, {"lowerIsBetter": false, "replicates": [1094.5676457799163, 1366.5285476510603, 1374.7937809328603, 1484.2282013353056, 1686.7891513560805, 5745.138229265613, 6805.285445028268, 6876.44988400928, 6882.759103431381, 6902.206246281679, 6683.766068187614, 6796.524243302971, 6805.251422343538, 6819.011243369709, 6824.112865327513, 1842.0697547738407, 1878.1829903991738, 1882.6422979633894, 1885.0480507343773, 1885.057471264368, 1916.875403098794, 1933.7679478462535, 1938.185961896, 1991.930282440115, 2007.5081605006794, 1937.4575118966711, 1952.5704345044066, 1955.4426988308335, 1955.501347156473, 1955.716421118937, 1905.3426567834144, 1936.1190658250462, 1942.0969249299073, 1942.5823447958758, 1943.24213556713, 1905.8189472000277, 1909.3985394600656, 1920.7791104023077, 1980.7821139674625, 1993.6212119697211, 7095.077639906831, 7157.284271572853, 7181.964090179516, 7182.066331376887, 7186.1735900371605, 4077.938830917539, 4138.337865941435, 4159.83360665573, 4172.666186705056, 4176.248275310443, 2600.2069368842494, 2655.5751079827137, 2687.4625074985083, 2710.593410988348, 2713.4030513287044, 799.5043073294595, 800.0599295827379, 808.3896658023154, 814.4990830639114, 829.8091438969071, 9418.340716149873, 9432.481213533252, 9458.33791634586, 9476.147146756755, 9502.144806967337, 3710.05393624624, 3730.694257010079, 3753.9436908446396, 3782.867599634, 3814.5231846019246, 7944.563049032358, 7982.640781164861, 8003.719869804645, 8038.115807261197, 8038.356931445471, 4097.774622395737, 4130.91738165241, 4133.111381053088, 4138.461999940048, 4162.666986641061, 3071.0633256856872, 3160.762942779301, 3766.453864189677, 3767.7550959188115, 3767.962320376761, 3253.4143854106014, 3324.135724711544, 3351.162209447638, 3352.396568617672, 3356.5300857879915, 1025.2464438637596, 1028.0285130551556, 1030.1861529391697, 1031.9174466042698, 1036.3108532825738, 898.3980732908967, 989.569537251298, 1097.1058587251364, 1102.7463683352873, 1103.051375816797, 6448.516361272923, 6514.3811337922825, 6517.055027021055, 6520.0, 6522.804315870531, 940.6049459227141, 945.8344789661919, 1010.0909181736349, 1034.0280136671504, 1034.7516596017051, 5030.0, 5030.572401345853, 5043.697378157322, 5060.51925067118, 5084.44071152173, 8152.307053900367, 8410.243078122998, 8411.579421028924, 8417.831643367099, 8427.915720842835, 8094.0, 8152.429329946846, 8279.089300176976, 8284.295834853985, 8291.0, 6522.869542609121, 6573.539852210395, 6573.934260657428, 6577.802665919934, 6581.769638062645, 6287.993920972623, 6308.589941653778, 6355.300916899045, 6366.745330186741, 6387.393197646216, 7406.666699998621, 7438.516496427715, 7477.027986361955, 7496.887546686695, 7509.88735168962, 7571.697132114874, 7612.80967975805, 7639.770806875803, 7708.730194443167, 7732.806679833049, 5280.419153892992, 5369.436209197978, 6090.056041313604, 6136.20229370179, 6139.631622102509, 6358.586691865014, 6418.133551970424, 6459.289478157493, 6473.579217351045, 6474.967625161844, 5984.730687119177, 6133.447989680772, 6142.723577438936, 6148.78479253224, 6288.496920246278, 5844.0, 5887.882242355215, 5911.645301281937, 5940.435658612425, 5968.46283834457, 6010.0, 6156.445919867234, 6191.628502289877, 6208.317085120543, 6235.906461402992, 5486.945130548644, 5494.725263736877, 5502.724863756716, 5505.119180931032, 5528.55771538284, 5625.184348269396, 5708.343540492897, 5712.628679136009, 5749.7125143741805, 5788.507976822018], "unit": "score", "name": "mootools.html", "value": 3918.637019129515}, {"lowerIsBetter": false, "replicates": [303.09828260923746, 307.403636944328, 309.9101260634416, 312.41734165780827, 315.48575821411094, 5357.8392648220515, 5401.243825864377, 5418.322709661293, 5442.210879422481, 5459.426760190177, 5092.363454568179, 5152.40747314059, 5248.5538729208065, 5345.625806193568, 5362.2224777407255, 4171.165766846628, 4181.728187667807, 4189.97905010476, 4195.265828480012, 4197.307444271692, 3972.7616343019367, 4187.1625674865145, 4188.81150348235, 4190.51809041961, 4191.497020357561, 4012.097278112416, 4039.8182081806244, 4131.091159944807, 4131.21506913687, 4137.958620413802, 4091.85678501254, 4116.9794151029355, 4119.258533463975, 4120.814563344627, 4129.380592911058, 3629.9274014519824, 3630.3283892479712, 3637.5998640149564, 3639.5450568678916, 3643.1074386775144, 5179.922301165486, 5212.322398088262, 5218.086834803894, 5218.817341393033, 5233.031889100491, 4560.8859778505475, 4705.811767529295, 4738.763061846894, 4754.524547545252, 4810.759462026885, 5643.971780141114, 5659.320881494205, 5660.433956604348, 5664.235328230719, 5667.376588575295, 3898.6549640374024, 3903.668188204006, 3903.9609603904164, 3905.628965248297, 3907.589703081164, 5895.4399332063385, 5987.37132601075, 5992.101184822268, 5997.7001149942325, 6000.18997435345, 3873.8063096845044, 3981.2634662587516, 3992.4210989406374, 4025.2150830587752, 4031.1937612477623, 4090.0388408723925, 4092.4475195848777, 4092.590740925943, 4092.7544347338658, 4094.877153685394, 4666.906661866811, 4698.224792909132, 4703.670743047954, 4715.3869996900185, 4716.339712440261, 5678.716064196774, 5686.687232202268, 5688.0, 5688.033034384164, 5689.061304884648, 1413.4487549855564, 1418.4609848257803, 1448.3120517754194, 1448.3989144505124, 1452.6876721504927, 948.805494873563, 973.6056896956744, 974.201155052864, 988.253868329421, 988.7182153086336, 4971.45314015458, 4978.850634480971, 4982.128127577659, 4990.3762029746285, 4991.625628077909, 5864.44287792659, 5880.206172166702, 5893.116032595145, 5897.469227769521, 5898.911516327258, 4771.71369717818, 4830.130576496194, 4860.781264843091, 4944.1100601891285, 4953.554180123734, 3126.140311414379, 3145.716885480272, 3160.4627213373783, 3162.6679198683805, 3163.984180079085, 5535.612507124543, 5602.075657516464, 5605.047141985872, 5606.0, 5606.439356064361, 5905.911411328833, 6087.452129308295, 6099.359567245464, 6105.145279660851, 6107.84730381744, 5570.832875013756, 5580.553555715533, 5624.971875140598, 5626.831195064155, 5649.632773869603, 5960.135780311917, 5974.133750606225, 5974.701264936649, 5977.6114552553945, 5981.850453738692, 5818.127280907897, 5826.038703613856, 5827.59206855516, 5831.533477321889, 5832.0, 5514.503694667499, 5547.44525547442, 5622.6064175508955, 5623.775048997994, 5629.437056294501, 4131.97934010328, 4170.6871984601885, 4174.603412675791, 4175.018870565354, 4177.12280421115, 5841.561882858718, 5874.471297583238, 5887.293524777054, 5887.882242355215, 5892.793752218652, 5514.503694667499, 5640.0, 5645.830625081254, 5651.378348381757, 5654.3497497788285, 5570.080936645408, 5627.634203776742, 5630.774769009357, 5633.746481408264, 5636.915446268227, 5496.532794712494, 5519.144532597454, 5534.225208470898, 5577.107662773937, 5581.330240371181, 5684.431556844283, 5685.118806584986, 5685.971570142123, 5690.032694442038, 5691.0, 5381.3004309441085, 5543.445655434424, 5569.443055694398, 5588.077967135378, 5611.438856114356], "unit": "score", "name": "prototype.html", "value": 4249.361042722444}, {"lowerIsBetter": false, "replicates": [599.6731781179257, 618.3260246331498, 675.0785178231714, 689.3072462175513, 690.2476300832092, 11149.554017839288, 11332.263402878807, 11334.773304533905, 11337.773244535105, 11337.773244535114, 10542.367457952529, 10652.78694426113, 10654.25420220583, 10671.679849604525, 10673.092787113104, 621.363102819609, 625.9436650701437, 762.9580373079478, 768.0514564512822, 778.6145857800368, 777.7783331750452, 779.5673401262297, 786.001777742267, 786.1391776005265, 787.4527203593505, 781.847539729753, 786.6695987685157, 787.5943888897223, 787.5983248543256, 788.5662885413028, 641.1184621145925, 650.0703993289594, 797.0753925446484, 813.4346629092782, 814.8940637717118, 605.2192671453819, 605.4853374631572, 605.5186127028978, 605.7032054293409, 605.7667797897797, 10670.093042091432, 10802.621908233174, 10811.243212975094, 10818.188635852342, 10821.404822734747, 10291.948540257326, 11184.44077796107, 11459.312441253469, 11483.42582870853, 11601.303921764636, 9021.503817290046, 9027.4132181408, 9124.95437522808, 9203.0, 9270.351075424724, 2759.7240275972445, 2786.7909906757072, 2807.7894157938235, 2816.830990140578, 2869.6126022986837, 37186.44220336697, 37300.62699373026, 37463.625363746556, 37674.623253767386, 37719.86840394765, 9033.322500812465, 9113.635454581743, 9189.724308270763, 9280.071992800666, 9500.619975200914, 15535.766963495556, 15539.611509712122, 15548.300326485336, 15564.287928327874, 15586.0, 6156.938430615636, 6170.938290617037, 6260.436560709558, 6364.363563643598, 6462.386073323027, 3459.135216195951, 3507.31607336572, 3526.3123690880543, 3543.2542463873647, 3565.928681426357, 2632.4998250332374, 2656.973430265711, 2658.41514866729, 2659.654244948183, 2673.9866300668373, 471.4036743519451, 475.11628371229483, 478.0200588792961, 486.545080349874, 489.13911515731854, 498.9825356112519, 533.8345113014977, 557.5233175634855, 604.3261763134074, 627.159606127791, 7281.271872812782, 7297.781066567905, 7529.247075292427, 7633.694652213961, 7744.6902123914415, 400.49737579338324, 421.52578349356975, 445.625674433471, 451.63868904875966, 607.0984587886984, 3636.381815091441, 3653.214558869856, 3723.236736469017, 3729.1236559408517, 4200.7479551227025, 43586.56413435889, 43779.0, 43866.342004869955, 47563.5243647566, 48782.26826597604, 38537.421938670945, 38597.6140238594, 38638.420423693664, 39147.60852391497, 39324.60675393267, 38362.0, 39663.20673586512, 39783.40324895129, 41234.1753164935, 41304.58695413007, 7356.154042284991, 7361.374283185989, 7379.852402952019, 7508.887366689613, 7524.134724506752, 31593.8420307897, 32375.19062023374, 32384.514232286063, 32486.35027299488, 32552.186195345304, 36726.816365918, 39300.606993930836, 40135.3979690299, 40697.59302406938, 40792.3881141789, 9566.521673916415, 9885.357451765612, 10062.748431289276, 10136.898631013595, 10234.33476824004, 10903.0, 11262.0, 11268.661940141808, 11291.378974156172, 11350.205485616258, 10008.299419040597, 10403.271770975958, 10419.583216671552, 10626.415547144981, 10823.188260880308, 9718.319717619699, 10124.746881328027, 10150.939624150398, 10257.28199026061, 10444.009498166837, 10204.948975255076, 10291.320949586168, 10333.896661033294, 10449.895501045195, 10484.63303784364, 9127.0, 9171.587278572346, 9178.357514973888, 9251.583678734338, 9482.288828337765, 8536.189062039097, 8570.4000719949, 9018.278537717099, 9228.95385523068, 9441.763955901157], "unit": "score", "name": "yui.html", "value": 5472.408022294415}], "name": "dromaeo_css", "value": 6235.502517561789}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 112.0, 111.0, 113.0, 103.0, 114.0, 111.0, 103.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 154.0, 166.0, 131.0, 149.0, 161.0, 140.0, 168.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 159.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 82.0, 95.0, 72.0, 72.0, 72.0, 116.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 133.0, 97.0, 97.0, 96.0, 134.0, 98.0, 98.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 71.0, 71.0, 72.0, 71.0, 80.0, 69.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 83.0, 90.0, 85.0, 84.0, 86.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [124.0, 129.0, 119.0, 118.0, 119.0, 135.0, 128.0, 136.0, 128.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [137.0, 163.0, 139.0, 148.0, 148.0, 139.0, 151.0, 154.0, 140.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 73.0, 70.0, 69.0, 68.0, 69.0, 71.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1526.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [189.17896329928112], "unit": "score", "name": "DeltaBlue", "value": 349.49974799999995}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [2004.0080160320642], "unit": "score", "name": "RayTrace", "value": 369.254511}, {"lowerIsBetter": false, "replicates": [809.7165991902834], "unit": "score", "name": "Earley", "value": 823.0818049999997}, {"lowerIsBetter": false, "replicates": [12600.0], "unit": "score", "name": "Boyer", "value": 52.89388888888888}, {"lowerIsBetter": false, "replicates": [27108.108108108107], "unit": "score", "name": "RegExp", "value": 33.60562811565303}, {"lowerIsBetter": false, "replicates": [615.0061500615006], "unit": "score", "name": "Splay", "value": 132.504366}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19575.556821960254}]} 19:01:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19575.56"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1526.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6235.50"}}} 19:01:48 INFO - Return code: 0 19:01:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:01:48 ERROR - # TBPL SUCCESS # 19:01:48 INFO - Running post-action listener: _resource_record_post_action 19:01:48 INFO - Running post-run listener: _resource_record_post_run 19:01:49 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549101568; Read time: 12; Write time: 529376 19:01:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 227606528; Read time: 0; Write time: 298780 19:01:49 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320630784; Read time: 12; Write time: 230560 19:01:49 INFO - Running post-run listener: _upload_blobber_files 19:01:49 INFO - Blob upload gear active. 19:01:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:01:49 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 19:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:01:49 INFO - (blobuploader) - INFO - Open directory for files ... 19:01:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:01:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:01:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:50 INFO - (blobuploader) - INFO - Done attempting. 19:01:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:01:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:01:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:51 INFO - (blobuploader) - INFO - Done attempting. 19:01:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:01:51 INFO - Return code: 0 19:01:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:01:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:01:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db815832bd66bead9728688578e07dec3f8294de19af215146110df85144b32c7f19c7144199233bff9606d5496e1e940ccb848b9349009dc7f3c0f637817978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/840dae61f6f2bb838397be57813cc6e7b29915d26f383bcfb485bcdbcb12199daa73d378edfee7dbbf779cfbf060e0904c29347250998fe1f431ee99fc756256"} 19:01:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:01:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:01:51 INFO - Contents: 19:01:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db815832bd66bead9728688578e07dec3f8294de19af215146110df85144b32c7f19c7144199233bff9606d5496e1e940ccb848b9349009dc7f3c0f637817978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/840dae61f6f2bb838397be57813cc6e7b29915d26f383bcfb485bcdbcb12199daa73d378edfee7dbbf779cfbf060e0904c29347250998fe1f431ee99fc756256"} 19:01:51 INFO - Copying logs to upload dir... 19:01:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.126345 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-25 19:01:51.341001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 19:01:51.344519) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db815832bd66bead9728688578e07dec3f8294de19af215146110df85144b32c7f19c7144199233bff9606d5496e1e940ccb848b9349009dc7f3c0f637817978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/840dae61f6f2bb838397be57813cc6e7b29915d26f383bcfb485bcdbcb12199daa73d378edfee7dbbf779cfbf060e0904c29347250998fe1f431ee99fc756256"} build_url:https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/MHiR66EzRRC3KMoF4sdqTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db815832bd66bead9728688578e07dec3f8294de19af215146110df85144b32c7f19c7144199233bff9606d5496e1e940ccb848b9349009dc7f3c0f637817978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/840dae61f6f2bb838397be57813cc6e7b29915d26f383bcfb485bcdbcb12199daa73d378edfee7dbbf779cfbf060e0904c29347250998fe1f431ee99fc756256"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 19:01:51.370068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:01:51.370473) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451095226.83637-1787740719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:01:51.451875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 19:01:51.452195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 19:01:51.452522) ========= ========= Total master_lag: 0.23 =========