builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1452599969.79 results: success (0) buildid: 20160112025555 builduid: 07cfb7c874364d9e84fdd5f5d134490b revision: e790bba372f14241addda469a4bdb7ab00786ab3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.795416) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.795903) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.796425) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006531 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.824433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.824772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.847149) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.847487) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.904920) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.905265) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.905717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:29.906022) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 03:59:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2016-01-12 03:59:30 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105070 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:30.040250) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:30.040549) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020968 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:30.093224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:30.093569) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e790bba372f14241addda469a4bdb7ab00786ab3 --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 e790bba372f14241addda469a4bdb7ab00786ab3 --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=c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 03:59:30,428 truncating revision to first 12 chars 2016-01-12 03:59:30,428 Setting DEBUG logging. 2016-01-12 03:59:30,428 attempt 1/10 2016-01-12 03:59:30,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e790bba372f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 03:59:30,675 unpacking tar archive at: mozilla-central-e790bba372f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.578128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:30.686397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:30.686807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:30.713101) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:30.713558) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 03:59:30.713980) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-12 03:59:30.714281) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:31 INFO - MultiFileLogger online at 20160112 03:59:31 in /builds/slave/test 03:59:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:59:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:31 INFO - {'append_to_log': False, 03:59:31 INFO - 'base_work_dir': '/builds/slave/test', 03:59:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:59:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:31 INFO - 'branch': 'Firefox-Non-PGO', 03:59:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:31 INFO - 'config_files': ('talos/linux_config.py',), 03:59:31 INFO - 'default_actions': ('clobber', 03:59:31 INFO - 'read-buildbot-config', 03:59:31 INFO - 'download-and-extract', 03:59:31 INFO - 'populate-webroot', 03:59:31 INFO - 'create-virtualenv', 03:59:31 INFO - 'install', 03:59:31 INFO - 'run-tests'), 03:59:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:31 INFO - 'download_minidump_stackwalk': True, 03:59:31 INFO - 'download_symbols': 'ondemand', 03:59:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:31 INFO - 'installer_path': 'installer.exe', 03:59:31 INFO - 'log_level': 'info', 03:59:31 INFO - 'log_name': 'talos', 03:59:31 INFO - 'log_to_console': True, 03:59:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:31 INFO - 'opt_config_files': (), 03:59:31 INFO - 'pip_index': False, 03:59:31 INFO - 'sps_profile': False, 03:59:31 INFO - 'sps_profile_interval': 0, 03:59:31 INFO - 'suite': 'dromaeojs-e10s', 03:59:31 INFO - 'system_bits': '32', 03:59:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:31 INFO - 'title': 'talos-linux64-ix-004', 03:59:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:31 INFO - 'use_talos_json': True, 03:59:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:31 INFO - 'work_dir': 'build'} 03:59:31 INFO - ##### 03:59:31 INFO - ##### Running clobber step. 03:59:31 INFO - ##### 03:59:31 INFO - Running pre-action listener: _resource_record_pre_action 03:59:31 INFO - Running main action method: clobber 03:59:31 INFO - rmtree: /builds/slave/test/build 03:59:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:32 INFO - Running post-action listener: _resource_record_post_action 03:59:32 INFO - ##### 03:59:32 INFO - ##### Running read-buildbot-config step. 03:59:32 INFO - ##### 03:59:32 INFO - Running pre-action listener: _resource_record_pre_action 03:59:32 INFO - Running main action method: read_buildbot_config 03:59:32 INFO - Using buildbot properties: 03:59:32 INFO - { 03:59:32 INFO - "project": "", 03:59:32 INFO - "product": "firefox", 03:59:32 INFO - "script_repo_revision": "production", 03:59:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:59:32 INFO - "repository": "", 03:59:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:59:32 INFO - "buildid": "20160112025555", 03:59:32 INFO - "pgo_build": "False", 03:59:32 INFO - "basedir": "/builds/slave/test", 03:59:32 INFO - "buildnumber": 151, 03:59:32 INFO - "slavename": "talos-linux64-ix-004", 03:59:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:59:32 INFO - "platform": "ubuntu64_hw", 03:59:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:59:32 INFO - "branch": "mozilla-central", 03:59:32 INFO - "repo_path": "mozilla-central", 03:59:32 INFO - "revision": "e790bba372f14241addda469a4bdb7ab00786ab3", 03:59:32 INFO - "stage_platform": "linux64", 03:59:32 INFO - "builduid": "07cfb7c874364d9e84fdd5f5d134490b", 03:59:32 INFO - "slavebuilddir": "test" 03:59:32 INFO - } 03:59:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:59:32 INFO - Running post-action listener: _resource_record_post_action 03:59:32 INFO - ##### 03:59:32 INFO - ##### Running download-and-extract step. 03:59:32 INFO - ##### 03:59:32 INFO - Running pre-action listener: _resource_record_pre_action 03:59:32 INFO - Running main action method: download_and_extract 03:59:32 INFO - mkdir: /builds/slave/test/build/tests 03:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:32 INFO - https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/test_packages.json 03:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/test_packages.json 03:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:59:37 INFO - Downloaded 1302 bytes. 03:59:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:59:37 INFO - Using the following test package requirements: 03:59:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:59:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:37 INFO - u'jsshell-linux-x86_64.zip'], 03:59:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:59:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:59:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:59:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:59:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:59:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:37 INFO - https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:41 INFO - Downloaded 22758579 bytes. 03:59:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:59:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:59:42 INFO - Return code: 0 03:59:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:42 INFO - https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:53 INFO - Downloaded 22758579 bytes. 03:59:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:59:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:59:54 INFO - Return code: 0 03:59: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')]} 03:59:54 INFO - https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:59:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:59:56 INFO - Downloaded 11132285 bytes. 03:59:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 03:59:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:59:56 INFO - Return code: 0 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:59:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:59:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:59:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXLz0jJWToS5HhI1A-I16A/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 04:00:00 INFO - Downloaded 53867344 bytes. 04:00:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:00:00 INFO - mkdir: /builds/slave/test/properties 04:00:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:00 INFO - Contents: 04:00:00 INFO - build_url:https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:00:00 INFO - Running post-action listener: _resource_record_post_action 04:00:00 INFO - Running post-action listener: set_extra_try_arguments 04:00:00 INFO - ##### 04:00:00 INFO - ##### Running populate-webroot step. 04:00:00 INFO - ##### 04:00:00 INFO - Running pre-action listener: _resource_record_pre_action 04:00:00 INFO - Running main action method: populate_webroot 04:00:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:00 INFO - '--tppagecycles', 04:00:00 INFO - '7'], 04:00:00 INFO - 'tests': ['tsvgm']}}, 04:00:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:00:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:00:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:00:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:00:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:00:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:00 INFO - 'talos_options': ['--e10s'], 04:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:00 INFO - 'tests': ['damp', 'tps']}, 04:00:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:00 INFO - 'talos_options': ['--e10s'], 04:00:00 INFO - 'tests': ['damp', 'tps']}, 04:00:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:00:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:00 INFO - 'other': {'tests': ['a11yr', 04:00:00 INFO - 'ts_paint', 04:00:00 INFO - 'tpaint', 04:00:00 INFO - 'sessionrestore', 04:00:00 INFO - 'sessionrestore_no_auto_restore']}, 04:00:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:00:00 INFO - 'tests': ['a11yr', 04:00:00 INFO - 'ts_paint', 04:00:00 INFO - 'tpaint', 04:00:00 INFO - 'sessionrestore', 04:00:00 INFO - 'sessionrestore_no_auto_restore']}, 04:00:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:00:00 INFO - 'tests': ['a11yr', 04:00:00 INFO - 'ts_paint', 04:00:00 INFO - 'tpaint', 04:00:00 INFO - 'sessionrestore', 04:00:00 INFO - 'sessionrestore_no_auto_restore']}, 04:00:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:00:00 INFO - 'tests': ['a11yr', 04:00:00 INFO - 'ts_paint', 04:00:00 INFO - 'tpaint', 04:00:00 INFO - 'sessionrestore', 04:00:00 INFO - 'sessionrestore_no_auto_restore']}, 04:00:00 INFO - 'other_l64': {'tests': ['a11yr', 04:00:00 INFO - 'ts_paint', 04:00:00 INFO - 'tpaint', 04:00:00 INFO - 'sessionrestore', 04:00:00 INFO - 'sessionrestore_no_auto_restore']}, 04:00:00 INFO - 'other_nol64': {'tests': ['a11yr', 04:00:00 INFO - 'ts_paint', 04:00:00 INFO - 'tpaint', 04:00:00 INFO - 'sessionrestore', 04:00:00 INFO - 'sessionrestore_no_auto_restore']}, 04:00:00 INFO - 'svgr': {'tests': ['tsvgx', 04:00:00 INFO - 'tsvgr_opacity', 04:00:00 INFO - 'tart', 04:00:00 INFO - 'tscrollx', 04:00:00 INFO - 'cart']}, 04:00:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:00:00 INFO - 'tests': ['tsvgx', 04:00:00 INFO - 'tsvgr_opacity', 04:00:00 INFO - 'tart', 04:00:00 INFO - 'tscrollx', 04:00:00 INFO - 'cart']}, 04:00:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:00 INFO - 'tests': ['tp5o']}, 04:00:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:00 INFO - 'talos_options': ['--e10s'], 04:00:00 INFO - 'tests': ['tp5o']}, 04:00:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:00 INFO - 'talos_options': ['--xperf_path', 04:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:00 INFO - 'tests': ['tp5n']}, 04:00:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:00 INFO - 'talos_options': ['--e10s', 04:00:00 INFO - '--xperf_path', 04:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:00 INFO - 'tests': ['tp5n']}}, 04:00:00 INFO - 'talos.zip': {'path': '', 04:00:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:00 INFO - Running post-action listener: _resource_record_post_action 04:00:00 INFO - ##### 04:00:00 INFO - ##### Running create-virtualenv step. 04:00:00 INFO - ##### 04:00:00 INFO - Running pre-action listener: _resource_record_pre_action 04:00:00 INFO - Running main action method: create_virtualenv 04:00:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:00 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 04:00:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:00:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:00 INFO - Using real prefix '/usr' 04:00:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:02 INFO - Installing pip.................done. 04:00:02 INFO - Return code: 0 04:00:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0c9e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', '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 04:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:00:02 INFO - Using env: {'DISPLAY': ':0', 04:00:02 INFO - 'HOME': '/home/cltbld', 04:00:02 INFO - 'LANG': 'en_US.UTF-8', 04:00:02 INFO - 'LANGUAGE': 'en_US:en', 04:00:02 INFO - 'LOGNAME': 'cltbld', 04:00:02 INFO - 'MAIL': '/var/mail/cltbld', 04:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:02 INFO - 'MOZ_NO_REMOTE': '1', 04:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:02 INFO - 'NO_EM_RESTART': '1', 04:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:02 INFO - 'PWD': '/builds/slave/test', 04:00:02 INFO - 'SHELL': '/bin/bash', 04:00:02 INFO - 'SHLVL': '1', 04:00:02 INFO - 'TERM': 'linux', 04:00:02 INFO - 'TMOUT': '86400', 04:00:02 INFO - 'USER': 'cltbld', 04:00:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:02 INFO - '_': '/tools/buildbot/bin/python'} 04:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:03 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 04:00:03 INFO - Cleaning up... 04:00:03 INFO - Return code: 0 04:00:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:00:03 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')]} 04:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:03 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')]} 04:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:03 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 0x7fa0c9e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', '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 04:00:03 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 04:00:03 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 04:00:03 INFO - Using env: {'DISPLAY': ':0', 04:00:03 INFO - 'HOME': '/home/cltbld', 04:00:03 INFO - 'LANG': 'en_US.UTF-8', 04:00:03 INFO - 'LANGUAGE': 'en_US:en', 04:00:03 INFO - 'LOGNAME': 'cltbld', 04:00:03 INFO - 'MAIL': '/var/mail/cltbld', 04:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:03 INFO - 'MOZ_NO_REMOTE': '1', 04:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:03 INFO - 'NO_EM_RESTART': '1', 04:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:03 INFO - 'PWD': '/builds/slave/test', 04:00:03 INFO - 'SHELL': '/bin/bash', 04:00:03 INFO - 'SHLVL': '1', 04:00:03 INFO - 'TERM': 'linux', 04:00:03 INFO - 'TMOUT': '86400', 04:00:03 INFO - 'USER': 'cltbld', 04:00:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:03 INFO - '_': '/tools/buildbot/bin/python'} 04:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:03 INFO - Downloading/unpacking psutil>=0.7.1 04:00:03 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 04:00:03 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 04:00:03 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 04:00:03 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 04:00:03 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 04:00:03 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 04:00:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:00:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:05 INFO - Installing collected packages: psutil 04:00:05 INFO - Running setup.py install for psutil 04:00:05 INFO - building 'psutil._psutil_linux' extension 04:00:05 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 04:00:05 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 04:00:05 INFO - building 'psutil._psutil_posix' extension 04:00:05 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 04:00:05 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 04:00:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:05 INFO - Successfully installed psutil 04:00:05 INFO - Cleaning up... 04:00:05 INFO - Return code: 0 04:00:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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', '--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 0x7fa0c9e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', '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 04:00:05 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 04:00:05 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 04:00:05 INFO - Using env: {'DISPLAY': ':0', 04:00:05 INFO - 'HOME': '/home/cltbld', 04:00:05 INFO - 'LANG': 'en_US.UTF-8', 04:00:05 INFO - 'LANGUAGE': 'en_US:en', 04:00:05 INFO - 'LOGNAME': 'cltbld', 04:00:05 INFO - 'MAIL': '/var/mail/cltbld', 04:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:05 INFO - 'MOZ_NO_REMOTE': '1', 04:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:05 INFO - 'NO_EM_RESTART': '1', 04:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:05 INFO - 'PWD': '/builds/slave/test', 04:00:05 INFO - 'SHELL': '/bin/bash', 04:00:05 INFO - 'SHLVL': '1', 04:00:05 INFO - 'TERM': 'linux', 04:00:05 INFO - 'TMOUT': '86400', 04:00:05 INFO - 'USER': 'cltbld', 04:00:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:05 INFO - '_': '/tools/buildbot/bin/python'} 04:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:00:05 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 04:00:05 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 04:00:05 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 04:00:05 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 04:00:05 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 04:00:05 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 04:00:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:00:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:00:07 INFO - Installing collected packages: mozsystemmonitor 04:00:07 INFO - Running setup.py install for mozsystemmonitor 04:00:07 INFO - Successfully installed mozsystemmonitor 04:00:07 INFO - Cleaning up... 04:00:07 INFO - Return code: 0 04:00:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa0c9e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', '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 04:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:00:07 INFO - Using env: {'DISPLAY': ':0', 04:00:07 INFO - 'HOME': '/home/cltbld', 04:00:07 INFO - 'LANG': 'en_US.UTF-8', 04:00:07 INFO - 'LANGUAGE': 'en_US:en', 04:00:07 INFO - 'LOGNAME': 'cltbld', 04:00:07 INFO - 'MAIL': '/var/mail/cltbld', 04:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:07 INFO - 'MOZ_NO_REMOTE': '1', 04:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:07 INFO - 'NO_EM_RESTART': '1', 04:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:07 INFO - 'PWD': '/builds/slave/test', 04:00:07 INFO - 'SHELL': '/bin/bash', 04:00:07 INFO - 'SHLVL': '1', 04:00:07 INFO - 'TERM': 'linux', 04:00:07 INFO - 'TMOUT': '86400', 04:00:07 INFO - 'USER': 'cltbld', 04:00:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:07 INFO - '_': '/tools/buildbot/bin/python'} 04:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:09 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:10 INFO - Downloading docopt-0.6.1.tar.gz 04:00:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:10 INFO - Running setup.py install for blobuploader 04:00:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:10 INFO - Running setup.py install for requests 04:00:10 INFO - Running setup.py install for docopt 04:00:11 INFO - Successfully installed blobuploader requests docopt 04:00:11 INFO - Cleaning up... 04:00:11 INFO - Return code: 0 04:00:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:11 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 0x7fa0c9e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', '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 04:00:11 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 04:00:11 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 04:00:11 INFO - Using env: {'DISPLAY': ':0', 04:00:11 INFO - 'HOME': '/home/cltbld', 04:00:11 INFO - 'LANG': 'en_US.UTF-8', 04:00:11 INFO - 'LANGUAGE': 'en_US:en', 04:00:11 INFO - 'LOGNAME': 'cltbld', 04:00:11 INFO - 'MAIL': '/var/mail/cltbld', 04:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:11 INFO - 'MOZ_NO_REMOTE': '1', 04:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:11 INFO - 'NO_EM_RESTART': '1', 04:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:11 INFO - 'PWD': '/builds/slave/test', 04:00:11 INFO - 'SHELL': '/bin/bash', 04:00:11 INFO - 'SHLVL': '1', 04:00:11 INFO - 'TERM': 'linux', 04:00:11 INFO - 'TMOUT': '86400', 04:00:11 INFO - 'USER': 'cltbld', 04:00:11 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:11 INFO - '_': '/tools/buildbot/bin/python'} 04:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:11 INFO - Running setup.py (path:/tmp/pip-QUY4vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:11 INFO - Running setup.py (path:/tmp/pip-g8C3Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:11 INFO - Running setup.py (path:/tmp/pip-poKEH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:11 INFO - Running setup.py (path:/tmp/pip-4YksYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:11 INFO - Running setup.py (path:/tmp/pip-odOQv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:11 INFO - Running setup.py (path:/tmp/pip-jwUMZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:11 INFO - Running setup.py (path:/tmp/pip-ZdTBMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:11 INFO - Running setup.py (path:/tmp/pip-5n19Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:11 INFO - Running setup.py (path:/tmp/pip-hMFEHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:11 INFO - Running setup.py (path:/tmp/pip-eUG9De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:12 INFO - Running setup.py (path:/tmp/pip-9pZwFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:12 INFO - Running setup.py (path:/tmp/pip-ZSAtMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:12 INFO - Running setup.py (path:/tmp/pip-sWXsZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:12 INFO - Running setup.py (path:/tmp/pip-OxNrs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:12 INFO - Running setup.py (path:/tmp/pip-AIu7XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:12 INFO - Running setup.py (path:/tmp/pip-olIW4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:12 INFO - Running setup.py (path:/tmp/pip-zkU8jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:12 INFO - Running setup.py install for manifestparser 04:00:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:12 INFO - Running setup.py install for mozcrash 04:00:12 INFO - Running setup.py install for mozdebug 04:00:12 INFO - Running setup.py install for mozdevice 04:00:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:00:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:12 INFO - Running setup.py install for mozfile 04:00:13 INFO - Running setup.py install for mozhttpd 04:00:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Running setup.py install for mozinfo 04:00:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Running setup.py install for mozInstall 04:00:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Running setup.py install for mozleak 04:00:13 INFO - Running setup.py install for mozlog 04:00:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Running setup.py install for moznetwork 04:00:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Running setup.py install for mozprocess 04:00:13 INFO - Running setup.py install for mozprofile 04:00:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Running setup.py install for mozrunner 04:00:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Running setup.py install for mozscreenshot 04:00:14 INFO - Running setup.py install for moztest 04:00:14 INFO - Running setup.py install for mozversion 04:00:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:14 INFO - Cleaning up... 04:00:14 INFO - Return code: 0 04:00:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fa0c9e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', '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 04:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 04:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 04:00:14 INFO - Using env: {'DISPLAY': ':0', 04:00:14 INFO - 'HOME': '/home/cltbld', 04:00:14 INFO - 'LANG': 'en_US.UTF-8', 04:00:14 INFO - 'LANGUAGE': 'en_US:en', 04:00:14 INFO - 'LOGNAME': 'cltbld', 04:00:14 INFO - 'MAIL': '/var/mail/cltbld', 04:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:14 INFO - 'MOZ_NO_REMOTE': '1', 04:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:14 INFO - 'NO_EM_RESTART': '1', 04:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:14 INFO - 'PWD': '/builds/slave/test', 04:00:14 INFO - 'SHELL': '/bin/bash', 04:00:14 INFO - 'SHLVL': '1', 04:00:14 INFO - 'TERM': 'linux', 04:00:14 INFO - 'TMOUT': '86400', 04:00:14 INFO - 'USER': 'cltbld', 04:00:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:14 INFO - '_': '/tools/buildbot/bin/python'} 04:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:14 INFO - Running setup.py (path:/tmp/pip-zxR3wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:14 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)) 04:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:14 INFO - Running setup.py (path:/tmp/pip-3EpmnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:14 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)) 04:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:14 INFO - Running setup.py (path:/tmp/pip-NqAze1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:14 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)) 04:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:14 INFO - Running setup.py (path:/tmp/pip-KJqYX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:14 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)) 04:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:14 INFO - Running setup.py (path:/tmp/pip-hKHtBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:14 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)) 04:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:14 INFO - Running setup.py (path:/tmp/pip-Ul4p0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:14 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)) 04:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:14 INFO - Running setup.py (path:/tmp/pip-nhQegg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:15 INFO - Running setup.py (path:/tmp/pip-NIvJN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:15 INFO - Running setup.py (path:/tmp/pip-HKgdGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:15 INFO - Running setup.py (path:/tmp/pip-hJtw_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:15 INFO - Running setup.py (path:/tmp/pip-T31SdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:15 INFO - Running setup.py (path:/tmp/pip-WQQz5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:15 INFO - Running setup.py (path:/tmp/pip-vsRQAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:15 INFO - Running setup.py (path:/tmp/pip-PhnDMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:15 INFO - Running setup.py (path:/tmp/pip-IfLJJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:15 INFO - Running setup.py (path:/tmp/pip-S9xqC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:15 INFO - Running setup.py (path:/tmp/pip-rlgtn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:15 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)) 04:00:15 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)) 04:00:15 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)) 04:00:15 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)) 04:00:15 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)) 04:00:15 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)) 04:00:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:17 INFO - Downloading blessings-1.5.1.tar.gz 04:00:17 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 04:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:17 INFO - Installing collected packages: blessings 04:00:17 INFO - Running setup.py install for blessings 04:00:18 INFO - Successfully installed blessings 04:00:18 INFO - Cleaning up... 04:00:18 INFO - Return code: 0 04:00:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:00:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:18 INFO - Reading from file tmpfile_stdout 04:00:18 INFO - Current package versions: 04:00:18 INFO - argparse == 1.2.1 04:00:18 INFO - blessings == 1.5.1 04:00:18 INFO - blobuploader == 1.2.4 04:00:18 INFO - docopt == 0.6.1 04:00:18 INFO - manifestparser == 1.1 04:00:18 INFO - mozInstall == 1.12 04:00:18 INFO - mozcrash == 0.16 04:00:18 INFO - mozdebug == 0.1 04:00:18 INFO - mozdevice == 0.47 04:00:18 INFO - mozfile == 1.2 04:00:18 INFO - mozhttpd == 0.7 04:00:18 INFO - mozinfo == 0.9 04:00:18 INFO - mozleak == 0.1 04:00:18 INFO - mozlog == 3.1 04:00:18 INFO - moznetwork == 0.27 04:00:18 INFO - mozprocess == 0.22 04:00:18 INFO - mozprofile == 0.28 04:00:18 INFO - mozrunner == 6.11 04:00:18 INFO - mozscreenshot == 0.1 04:00:18 INFO - mozsystemmonitor == 0.0 04:00:18 INFO - moztest == 0.7 04:00:18 INFO - mozversion == 1.4 04:00:18 INFO - psutil == 3.1.1 04:00:18 INFO - requests == 1.2.3 04:00:18 INFO - wsgiref == 0.1.2 04:00:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:18 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')]} 04:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:18 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')]} 04:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:18 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 0x7fa0c9e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', '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 04:00:18 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 04:00:18 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 04:00:18 INFO - Using env: {'DISPLAY': ':0', 04:00:18 INFO - 'HOME': '/home/cltbld', 04:00:18 INFO - 'LANG': 'en_US.UTF-8', 04:00:18 INFO - 'LANGUAGE': 'en_US:en', 04:00:18 INFO - 'LOGNAME': 'cltbld', 04:00:18 INFO - 'MAIL': '/var/mail/cltbld', 04:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:18 INFO - 'MOZ_NO_REMOTE': '1', 04:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:18 INFO - 'NO_EM_RESTART': '1', 04:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:18 INFO - 'PWD': '/builds/slave/test', 04:00:18 INFO - 'SHELL': '/bin/bash', 04:00:18 INFO - 'SHLVL': '1', 04:00:18 INFO - 'TERM': 'linux', 04:00:18 INFO - 'TMOUT': '86400', 04:00:18 INFO - 'USER': 'cltbld', 04:00:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:18 INFO - '_': '/tools/buildbot/bin/python'} 04:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:18 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)) 04:00:18 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)) 04:00:18 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)) 04:00:18 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)) 04:00:18 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)) 04:00:18 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)) 04:00:18 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)) 04:00:18 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)) 04:00:18 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)) 04:00:18 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)) 04:00:18 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)) 04:00:18 INFO - Cleaning up... 04:00:18 INFO - Return code: 0 04:00:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00:18 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')]} 04:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:18 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')]} 04:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:18 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 0x7fa0c9e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', '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 04:00:18 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 04:00:18 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 04:00:18 INFO - Using env: {'DISPLAY': ':0', 04:00:18 INFO - 'HOME': '/home/cltbld', 04:00:18 INFO - 'LANG': 'en_US.UTF-8', 04:00:18 INFO - 'LANGUAGE': 'en_US:en', 04:00:18 INFO - 'LOGNAME': 'cltbld', 04:00:18 INFO - 'MAIL': '/var/mail/cltbld', 04:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:18 INFO - 'MOZ_NO_REMOTE': '1', 04:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:18 INFO - 'NO_EM_RESTART': '1', 04:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:18 INFO - 'PWD': '/builds/slave/test', 04:00:18 INFO - 'SHELL': '/bin/bash', 04:00:18 INFO - 'SHLVL': '1', 04:00:18 INFO - 'TERM': 'linux', 04:00:18 INFO - 'TMOUT': '86400', 04:00:18 INFO - 'USER': 'cltbld', 04:00:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:18 INFO - '_': '/tools/buildbot/bin/python'} 04:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:18 INFO - Downloading/unpacking jsonschema 04:00:18 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 04:00:18 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 04:00:18 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 04:00:18 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 04:00:18 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 04:00:18 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 04:00:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:20 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 04:00:20 INFO - Downloading/unpacking functools32 (from jsonschema) 04:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:20 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:20 INFO - warning: no files found matching '*.txt' 04:00:20 INFO - no previously-included directories found matching 'build' 04:00:20 INFO - no previously-included directories found matching 'dist' 04:00:20 INFO - no previously-included directories found matching '.git*' 04:00:20 INFO - Installing collected packages: jsonschema, functools32 04:00:20 INFO - Running setup.py install for functools32 04:00:20 INFO - warning: no files found matching '*.txt' 04:00:20 INFO - no previously-included directories found matching 'build' 04:00:20 INFO - no previously-included directories found matching 'dist' 04:00:20 INFO - no previously-included directories found matching '.git*' 04:00:20 INFO - Successfully installed jsonschema functools32 04:00:20 INFO - Cleaning up... 04:00:20 INFO - Return code: 0 04:00:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:00:20 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')]} 04:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:20 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')]} 04:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:20 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 0x7fa0c9e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', '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 04:00:20 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 04:00:20 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 04:00:20 INFO - Using env: {'DISPLAY': ':0', 04:00:20 INFO - 'HOME': '/home/cltbld', 04:00:20 INFO - 'LANG': 'en_US.UTF-8', 04:00:20 INFO - 'LANGUAGE': 'en_US:en', 04:00:20 INFO - 'LOGNAME': 'cltbld', 04:00:20 INFO - 'MAIL': '/var/mail/cltbld', 04:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:20 INFO - 'MOZ_NO_REMOTE': '1', 04:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:20 INFO - 'NO_EM_RESTART': '1', 04:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:20 INFO - 'PWD': '/builds/slave/test', 04:00:20 INFO - 'SHELL': '/bin/bash', 04:00:20 INFO - 'SHLVL': '1', 04:00:20 INFO - 'TERM': 'linux', 04:00:20 INFO - 'TMOUT': '86400', 04:00:20 INFO - 'USER': 'cltbld', 04:00:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:20 INFO - '_': '/tools/buildbot/bin/python'} 04:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:21 INFO - Downloading/unpacking flake8 04:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:00:23 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 04:00:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:00:24 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 04:00:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:00:24 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 04:00:24 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 04:00:24 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 04:00:24 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 04:00:24 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 04:00:24 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 04:00:24 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 04:00:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:00:24 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 04:00:24 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 04:00:24 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 04:00:24 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 04:00:24 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 04:00:24 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 04:00:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:24 INFO - no previously-included directories found matching 'docs/_build' 04:00:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:00:24 INFO - Running setup.py install for pep8 04:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:24 INFO - no previously-included directories found matching 'docs/_build' 04:00:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:00:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:00:24 INFO - Cleaning up... 04:00:24 INFO - Return code: 0 04:00:24 INFO - Running post-action listener: _resource_record_post_action 04:00:24 INFO - Running post-action listener: _start_resource_monitoring 04:00:24 INFO - Starting resource monitoring. 04:00:24 INFO - ##### 04:00:24 INFO - ##### Running install step. 04:00:24 INFO - ##### 04:00:24 INFO - Running pre-action listener: _resource_record_pre_action 04:00:24 INFO - Running main action method: install 04:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:24 INFO - Reading from file tmpfile_stdout 04:00:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:25 INFO - Reading from file tmpfile_stdout 04:00:25 INFO - Output received: 04:00:25 INFO - Usage: mozinstall [options] installer 04:00:25 INFO - Options: 04:00:25 INFO - -h, --help show this help message and exit 04:00:25 INFO - -d DEST, --destination=DEST 04:00:25 INFO - Directory to install application into. [default: 04:00:25 INFO - "/builds/slave/test"] 04:00:25 INFO - --app=APP Application being installed. [default: firefox] 04:00:25 INFO - mkdir: /builds/slave/test/build/application 04:00:25 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'] 04:00:25 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 04:00:40 INFO - Reading from file tmpfile_stdout 04:00:40 INFO - Output received: 04:00:40 INFO - /builds/slave/test/build/application/firefox/firefox 04:00:40 INFO - Running post-action listener: _resource_record_post_action 04:00:40 INFO - ##### 04:00:40 INFO - ##### Running run-tests step. 04:00:40 INFO - ##### 04:00:40 INFO - Running pre-action listener: _resource_record_pre_action 04:00:40 INFO - Running main action method: run_tests 04:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:40 INFO - Python 2.7.3 04:00:40 INFO - Return code: 0 04:00:40 INFO - grabbing minidump binary from tooltool 04:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:40 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 0xe743d0>, '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 0xddfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde0360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:40 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 04:00:40 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 04:00:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:40 INFO - Return code: 0 04:00:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:00:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:00:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:00:41 INFO - Return code: 0 04:00:41 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:00:41 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:00:41 INFO - Using env: {'DISPLAY': ':0', 04:00:41 INFO - 'HOME': '/home/cltbld', 04:00:41 INFO - 'LANG': 'en_US.UTF-8', 04:00:41 INFO - 'LANGUAGE': 'en_US:en', 04:00:41 INFO - 'LOGNAME': 'cltbld', 04:00:41 INFO - 'MAIL': '/var/mail/cltbld', 04:00:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:41 INFO - 'MOZ_NO_REMOTE': '1', 04:00:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:41 INFO - 'NO_EM_RESTART': '1', 04:00:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:41 INFO - 'PWD': '/builds/slave/test', 04:00:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:41 INFO - 'SHELL': '/bin/bash', 04:00:41 INFO - 'SHLVL': '1', 04:00:41 INFO - 'TERM': 'linux', 04:00:41 INFO - 'TMOUT': '86400', 04:00:41 INFO - 'USER': 'cltbld', 04:00:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245', 04:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:41 INFO - '_': '/tools/buildbot/bin/python'} 04:00:41 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:00:41 INFO - mozversion application_buildid: 20160112025555 04:00:41 INFO - mozversion application_changeset: e790bba372f14241addda469a4bdb7ab00786ab3 04:00:41 INFO - mozversion application_display_name: Nightly 04:00:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:41 INFO - mozversion application_name: Firefox 04:00:41 INFO - mozversion application_remotingname: firefox 04:00:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:00:41 INFO - mozversion application_vendor: Mozilla 04:00:41 INFO - mozversion application_version: 46.0a1 04:00:41 INFO - mozversion platform_buildid: 20160112025555 04:00:41 INFO - mozversion platform_changeset: e790bba372f14241addda469a4bdb7ab00786ab3 04:00:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:00:41 INFO - mozversion platform_version: 46.0a1 04:00:41 INFO - using testdate: 1452600041 04:00:41 INFO - actual date: 1452600041 04:00:41 INFO - starting webserver on 'localhost:59471' 04:00:41 INFO - SUITE-START | Running 3 tests 04:00:41 INFO - TEST-START | dromaeo_css 04:00:41 INFO - operating with platform_type : linux_ 04:00:41 INFO - Initialising browser for dromaeo_css test... 04:00:41 INFO - TEST-INFO | started process 25247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1MS1K3/profile http://localhost:59471/getInfo.html) 04:00:45 INFO - PROCESS | 25247 | 04:00:45 INFO - PROCESS | 25247 | (process:25330): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:47 INFO - PROCESS | 25247 | __metrics Screen width/height:1600/1200 04:00:47 INFO - PROCESS | 25247 | colorDepth:24 04:00:47 INFO - PROCESS | 25247 | Browser inner width/height: 1024/697 04:00:47 INFO - PROCESS | 25247 | __metrics 04:00:47 INFO - PROCESS | 25247 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:00:48 INFO - TEST-INFO | 25247: exit 0 04:00:48 INFO - Browser initialized. 04:00:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:48 INFO - TEST-INFO | started process 25379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1MS1K3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:49 INFO - PROCESS | 25379 | 04:00:49 INFO - PROCESS | 25379 | (process:25435): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:01:00 INFO - PROCESS | 25379 | RSS: Main: 150401024 04:01:00 INFO - PROCESS | 25379 | 04:01:50 INFO - PROCESS | 25379 | 1452600110055 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] 04:04:00 INFO - PROCESS | 25379 | Cycle 1(1): loaded http://localhost:59471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59471/tests/dromaeo/cssquery-ext.html) 04:04:01 INFO - PROCESS | 25379 | RSS: Main: 153276416 04:04:01 INFO - PROCESS | 25379 | 04:07:03 INFO - PROCESS | 25379 | Cycle 1(1): loaded http://localhost:59471/tests/dromaeo/cssquery-ext.html (next: http://localhost:59471/tests/dromaeo/cssquery-jquery.html) 04:07:04 INFO - PROCESS | 25379 | RSS: Main: 151560192 04:07:04 INFO - PROCESS | 25379 | 04:10:05 INFO - PROCESS | 25379 | Cycle 1(1): loaded http://localhost:59471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59471/tests/dromaeo/cssquery-mootools.html) 04:10:06 INFO - PROCESS | 25379 | RSS: Main: 151502848 04:10:06 INFO - PROCESS | 25379 | 04:13:08 INFO - PROCESS | 25379 | Cycle 1(1): loaded http://localhost:59471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59471/tests/dromaeo/cssquery-prototype.html) 04:13:09 INFO - PROCESS | 25379 | RSS: Main: 149975040 04:13:09 INFO - PROCESS | 25379 | 04:16:11 INFO - PROCESS | 25379 | Cycle 1(1): loaded http://localhost:59471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59471/tests/dromaeo/cssquery-yui.html) 04:16:12 INFO - PROCESS | 25379 | RSS: Main: 150843392 04:16:12 INFO - PROCESS | 25379 | 04:19:14 INFO - PROCESS | 25379 | Cycle 1(1): loaded http://localhost:59471/tests/dromaeo/cssquery-yui.html (next: http://localhost:59471/tests/dromaeo/cssquery-dojo.html) 04:19:15 INFO - PROCESS | 25379 | RSS: Main: 153616384 04:19:15 INFO - PROCESS | 25379 | 04:19:15 INFO - PROCESS | 25379 | __start_tp_report 04:19:15 INFO - PROCESS | 25379 | _x_x_mozilla_page_load 04:19:15 INFO - PROCESS | 25379 | _x_x_mozilla_page_load_details 04:19:15 INFO - PROCESS | 25379 | |i|pagename|runs| 04:19:15 INFO - PROCESS | 25379 | |0;dojo.html;2625.461780335031;2640.9339766505846;2667.0265353146096;2673.7459941305583;2679.705232424433;4419.226635338819;4518.457785065792;4531.297648864423;4575.748333841638;4612.285095810146;4446.866594002185;4461.464624245087;4528.275475923853;4541.227991241489;4588.632909367251;20.993349792582222;4224.387463817737;4227.577242275778;4254.127903779718;4327.545607711192;4013.1572369802375;4102.323116685759;4155.750654960712;4160.271952408331;4203.117345357463;4234.68239882007;4243.596858298472;4246.830126794925;4257.489101307848;4280.122574872144;4213;4243.363495475673;4251.27728286189;4258.42511260982;4303.892402689927;4091.1408604193157;4145.730527515732;4156.376543518466;4162.958370416318;4165.208610364021;4479.440069991251;4482.260427029536;4494.415725955605;4507.909841803145;4537.795799189044;4889.4377146627885;4917.72952487613;4922.606191504707;4932.457429682732;4971.602271818246;4749.525047495257;4824.396950381202;4860.562549370538;4941.925871111936;4946.109700253953;4583.462063604384;4602.05657840142;4603.10239503297;4615.284630882219;4630.536946305342;4968.30443737877;4985.825496107619;5017.523335283142;5029.748512574357;5066.240063990357;4746.905061898743;4772.045590881838;4814.831480898151;4853.563179313879;4855.902881942341;4895.412550493964;4924.8768780780765;4940.49783560568;4943.826966056171;4985.9501404985485;4859.125357435695;4867.245576935581;4889.779959901813;4892.437369702458;4928.48250933654;4695.882602934954;4752.572268495852;4766.785494652749;4816.325714399987;4849.878753031202;3800.733948623625;3806.2577797329254;3810.504634397566;3839.308924393636;3853.402722578005;3327.617324007722;3424.5890493140982;3436.6563343665935;3461.7576769625884;3476.8435420406145;4180.874573762792;4240.851570195028;4261.680373971903;4280.6789490788315;4298.763568003727;4764.809407623726;4766.6901651392545;4815.281024595845;4816.060868130681;4855.902881942341;4177.958220417818;4193.056562273464;4194.769287689206;4208.431861698631;4243.405923170759;4341.826326946887;4408.933865992013;4415.183191109655;4422.248217802981;4428.6678499112695;4621.907561848677;4627.699199552018;4675.485696573374;4690.671652984327;4730.574248317736;4760.833370832004;4815.253635686474;4891.95108048915;4901.9264711028645;4911.926321105115;4697.483276839476;4701.294805779161;4707.2939059140035;4710.105080034782;4721.598664113589;4856.247281671205;4870.805167793249;4887.780049897692;4895.4370247422;4914.238293064581;4717.198076327101;4811.061842940593;4830.637702172281;4913.287573301923;4919.483454237254;4700.153972285021;4714.222153344797;4740.170470167775;4756.286557016475;4783.330333753347;4678.041001594733;4723.149833030087;4729.881752956066;4735.763211839463;4781.665283430127;4600.539946005507;4611.5619016193405;4645.419322584677;4674.649401294849;4679.672422930362;4688.226442637063;4697.553732395417;4709.481956984798;4722.1028004679;4751.667383283137;4569.611583015481;4618.053299073615;4621.768911554476;4633.467151277646;4663.696859704109 04:19:15 INFO - PROCESS | 25379 | |1;ext.html;481.9903601927962;485.5702703107749;490.24012780190674;504.1278588042686;518.6913786297151;32166.356672866557;32727.836360818193;32768;32774.67225327749;32802.34395312092;35798.64201357992;36563.81718091413;36661;36699.81650091753;36753.816230918805;7636.809079773008;7732.304092631662;7773.844523109535;7779.105402878657;7791.142974272825;7560;7649.808754781119;7676.040494938133;7684.615769211545;7721.806954826118;7779.572123533203;7850.2542258485355;7860.253275938777;7912.881306780403;7916.564588947605;7703.576303303316;7810.960945195295;7822.061352637663;7831.668616335237;7850.882236766453;7552.8867066994035;7604.0875094988405;7611.6574754135645;7659.157492675801;7670.0795904491815;36869;37224.255514889825;37351.813240933894;37387.626123738955;37428.62571374306;2365.29041287613;2819.2388055224974;2922.8684709187924;3029.3184033592484;3071.1247294520954;24425.633615495783;28096;28842.567361489593;28853;28958.131256062352;3178.55500229968;3198.5362122492343;3207.1661368044242;3218.2115381731624;3276.6231883333244;166823.1658841698;168513;168959;169362;169496;46517.30224046642;50004.49995500071;50111.49888501141;50193.24710129351;50341.74829125831;40070.39894401586;59840;60622.878199262814;60673.39326606766;60678;13623.318834058457;13665.931670341784;13694.657633559042;13813.792793108112;13831.239281839595;10437;10523.52644131016;10539.525721342558;10548.47257637115;10629.149668026539;18239.817601824077;18399.908000459913;18619.348322808637;18643.533911652317;18668.81331186698;6640.734370625121;6818.420434263143;6841.110655614738;6889.414399776075;6982.546134501241;827.8840962265288;888.648983651454;902.3232575568323;994.8259054665405;1013.6604237580493;23836.88081559616;23939.640905386434;24009.639855402183;24062.51874962526;24307.27078187657;909.6816114359921;934.4580143516744;988.658912675126;988.8813342398959;998.1266391907081;13075.280859552626;15084.773728394082;15188.924055379874;15212.46756363522;15438.845611543966;304410;308244;309668;311051;311865;47768;48284;48334;48486.75756621194;48533.5146648536;1197.437204513877;1216.3639904328663;1234.1422711215619;1245.8131280308025;1247.7629250442387;27475.31311717223;28063.43873122567;28147.296317591405;28334.858325709065;30546.389072218877;42762.78618606887;43376.132477349645;43398.78300608603;43401.3489797647;43551.34672979971;232598;235284;235405;235599;235762;32002.679973200902;32669.673303267613;37097.98354444339;38082.61917380791;39122.217555649295;34490.655093448746;38196.42705359477;38370.80814595909;39211.823645290686;39274.80362598169;32721;33205.169870752456;33873.49189762205;34025.65974340225;34138.31723365469;32733.34533309273;32834.835825820715;33548.161295967795;33789.83105084459;33835;32563.511547326336;33122.66877331196;33191.83404082964;33224.33551329008;33244.66755332416;28348;29944;29979.255692247963;30309.090727278217;30510.237244069074;24623;25064.37339066538;25208.495830083662;25341.74658253394;25482.490350192522 04:19:15 INFO - PROCESS | 25379 | |2;jquery.html;332.7005694874614;338.2727136656189;340.02921658664513;343.92605589798194;346.9271452994871;11939.522419103225;12357.629271121858;14484.420623175074;14604;16386.098764567945;9905.702828915126;10230.43732594707;10240.28318017739;14924.925375373108;15527.844721552781;4496.325551167327;4635.536446355354;4641.93037104442;4646.372739680134;4649.139909116824;4888.535589119028;4957.752112394366;4972.0801651694555;4978.377702787152;4979.875503112415;4786.952130478703;4959.900801983958;4969.329140566031;4984.127777638917;4984.925226121611;4921.655484116113;4970.552650261494;4971.179755340365;4975.303457515951;4982.725950072744;4331.859401933604;4416.33754936762;4471.463424389061;4487.147441986012;4509.098180363941;17811.73282400765;18139.004709481946;18366.449006529692;18473;18567.907160464245;1823.0793449308146;1878.4083013850593;1919.078842155759;1922.7596550431197;1929.9710504342447;9031.322650801216;9076.636934522678;9269.953650231773;10244.436555989418;12388.81416778749;1717.9570510737205;1766.240516577871;1770.6104656975444;1780.9545082272407;1781.0649409060347;48835.51164488345;48962.75518622384;49934.75032624813;50465.495345046445;50798.23802642963;9624;9649.083337082966;9800.852987205197;9833.4099954003;9869.161121304769;12422.819832115934;12522.81215781764;21034.368968930958;21113.577728445653;21604.4598885026;8028.518288902685;8039.598020098972;8039.799005024921;8074.959625201836;8294.543800091053;6313.779017734358;6517.576357536745;6838.21360543534;6868.828279293058;7350.669219885118;7220.3140701633265;7232.891506627405;7263.782086537412;7301.1968683444775;7411.295926886937;2988.7608991280645;3043.3761078978755;3052.923676908095;3112.8754849806205;3202.583664123649;794.8092457810084;822.942394032424;836.761522965964;884.6638277454655;925.4262357338494;14595.92702036483;14985.250737463084;15457.5362739118;15749.606259843596;15810.209489525478;888.9733308000771;894.1000374204815;902.1970446302796;920.8802855628859;956.7608097975506;8903.688370906988;8977.640894364284;8985.415947963362;9146.588403521857;9251.306152038624;447228;448713;455923;459517;463723;65278;65606.67196663986;65879.67060164764;65982;66524;1092.1372116028408;1102.366139469808;1140.4696815980608;1173.372245848467;1174.3482367286067;13049;13198.60404187876;13598.184108953494;14017.859821402064;14126.364313606118;27634.309142271602;27737.167884963485;28027.43945121127;28919.566206506497;29233.41533169367;32173.517397239528;33254.33491330208;35363.11592210215;37373.62626373702;37832;6412.454941330039;6576.80269591913;6754.5609535380045;6794.116764820542;6888.138982627172;9014.278857691237;9957.763726788678;10261.58953641846;10418.479076046318;10561.471926403803;7238.846980066901;7253.637318133967;7980.441369104107;8027.719029833927;8444.451110677786;8180.631871565913;8308.584570771316;8431.934176126888;8496.830063398822;8531.914680853111;2575.5364034473223;2588.1200391866855;5014.34813474246;7060.775855605468;8384.83230335402;6623.768168114093;6841.452683785185;6846.418054465426;6902.206246281742;6904.447644188554;6765.2896445872475;7776.183500732342;8213.753587392388;8274.462159959583;8336.458130221516 04:19:15 INFO - PROCESS | 25379 | |3;mootools.html;1388.1879100726076;1393.5053056165061;1504.7366710825602;1677;1699.0400423760566;6298.527610429213;6495.188101487314;7275.29030677791;7474.065741782278;7496.362809161221;6975.965120174392;7060.7528736494105;7203.639818009092;7216.278372162794;7227.819304517389;2159.276642324823;2209.2930262316067;2209.9116035358566;2209.94475138122;2213;2074.761402438724;2081.198738485679;2149.6775483677416;2152.3650523095725;2161.448830548208;2144.4638840289927;2149.656055031195;2160.2115227941767;2160.9783902160934;2206.1396055538353;2191.7589065202815;2191.780821917803;2202.8347873909443;2204.669299605056;2205.580939621475;2160.3950893749775;2200.3179014505554;2202.7797220277844;2206.117552978805;2206.360155554903;7551.169371369145;7591.127020392671;7604.315611594983;7655.081390233152;7658.157602663702;4248.638865696419;4344.1311737652595;4369.257226271541;4390.714603550759;4404.625606823424;2284.7601001894895;2357.5049239659693;2702.5135475614384;2756.0491630387683;2765.2948498132846;815.1929589706208;829.2122483640505;835.1147783349669;835.4569529805614;849.8257857139272;10124.89875101247;10140.89859101407;10147.036031576989;10158.644447444378;10182.338148020355;4144.088300573869;4154.8338066477;4234.597713217239;4238.788060596958;4249.68127390447;8928.598213080428;8947.239484643878;8959.328050396247;8972.147645973622;8984.685536006209;4541.318802179633;4572.7713614319155;4578.427696537933;4584.266517357207;4599.264117741212;4096.959030409717;4109.568495308009;4133.958660413357;4161.126163505637;4161.771102589326;3485.634008429129;3489;3493.3013397320638;3534.0634731796094;3552.0764601203355;1148.0757989818276;1151.9193656443967;1152.9884701153048;1157.8147496400536;1160.4739767206097;916.0473107967772;939.6053657463882;1156.9652910412701;1164.1036401970605;1172.3434876469205;6592.5055620828625;6632.734690612321;6643.335666433318;6659.633720145342;6680.131582894192;1013.5287091502487;1038.3354653022072;1044.4621020174616;1044.9791004179874;1083.47992963378;5020.2720605511995;5038.2190760432195;5039.77321020555;5046;5077.086124497552;7841;8299.419040667095;8732.738017859474;8773.07882672323;8809.282189973022;8551.059383467813;8575.95712021436;8592.957035214784;8619.569021548898;8627.43921645091;6606.7026983785845;6744.865102697919;6804.421624161902;6911.516193866381;7007.5795452272005;6749.751296010254;6815.93184068153;6821.488388370793;6853.4859885507785;6855.348741869514;7579.924200757921;7754.340881025176;7800.063992320957;7881.566513841564;7890.053193616803;7730.613469326624;7903.091144518224;7961.9203807963495;7967.56178410193;7968.681252749825;6055.424734650202;6138.079288106641;6165.075238714228;6170.10533472653;6190.566660333733;6929.965350173217;7080.504364694422;7084.043654106629;7104.857902841811;7108.040414543971;6668.099806526251;6682.966585167043;6750.29121942189;6801.18385793708;6836.623985680636;6726.7981960541265;6740.224874139537;6829.180498340231;6850.126126305372;6884.724611015503;6886.965565172142;6958.826029349307;6960.129983752031;6967.372936435745;6975.546589471668;6121;6275.6862156892885;6290.21372328459;6305.8108256752375;6312.2740884796995;6409.7115629795835;6425.775097871552;6470.417662410406;6471.482281417381;6485.77299794505 04:19:15 INFO - PROCESS | 25379 | |4;prototype.html;312.3378437712051;315.6065968747978;318.97926634768754;320.46642340503064;328.06174341383644;5569.220309156716;5680.8295751127425;5784.537237021033;5787.797427090053;5803.970980145104;5612.915806262909;5643.068893632546;5678.290213723285;5680.147977803332;5683;4191.476065491814;4297.849575264866;4301.161273551658;4301.956980430203;4332.718373305741;4292.957070429303;4311.3748506466545;4328.653707703376;4335.414719012941;4343.804528796211;4287.20686672965;4302.655787537005;4308.138372325532;4309.870703878889;4317.525072242051;4303.26844436445;4306.224879521685;4307.82768689252;4316.740995540277;4319.913601727979;3632.7093832493338;3734.6265373462707;3735.794531300777;3738.925221495555;3744.251149770057;5287;5447.618666693333;5451.64564303319;5451.918221226685;5454.263674403945;4922.286268491049;4943.505649435064;4948.307236986825;4955.554000140005;4965.726885021322;5938.732757025944;5941.019731744257;5945.227120474311;5959.940400595982;5960.493358064569;3938.3895496198134;4062.7156099073077;4064.512258528966;4082.326416141333;4084.1627466369323;6202.875942481171;6209.099680546341;6280.089387038854;6281.654509002003;6290.24517057956;4173.812178451977;4180.581941805795;4195;4196.391523229115;4198.244316023145;4237.385579091015;4251.681123915719;4258.339957306623;4269.996550810557;4280.315149576053;4737.076270127292;4791.95208047922;4852.757362131879;4899.240617704261;4916.139675556763;5898.056310990221;5939.643621382731;5947.286325640865;5985.610935289193;5986.5210783137245;1488.0327786938576;1515.886308526865;1521.9010764300285;1522.6345677037432;1524.1845612597428;958.5303201431249;1005.4319309590204;1018.1905385218769;1022.0188618925766;1023.2376879225025;5142.0744266031725;5185.325907632059;5205.713685747244;5210.8957820844125;5216.504432078947;6124.908126378108;6133.877322453526;6150.292716337678;6151.108089327023;6184.257889053342;5161.5870730341485;5166.509181627739;5201.843944681666;5206.401263854706;5209.71346575942;3267.3138640885204;3335.483000134983;3352.1116904020455;3381.1716129548417;3405.182756138509;5832.12518122285;5843.035899076604;5872.882542349214;5876.7355469004;5885.323187833368;6455.289918109004;6474.9676251619385;6478.578892371981;6489.643069631215;6495.447886929664;5710.914336284959;5892.646441213541;5899.056151015817;5906.675132867734;5921.970390148108;6278.748850045947;6286.18279623646;6293.465055470337;6302.086197501245;6302.810915672537;6106.8167954959645;6114.266288045285;6140.508759299335;6140.662263575547;6147.66187859672;5779.2775903012125;5888.381719919346;5907.793227237026;5919.171316015675;5922.5261979040715;4171.311733564049;4213.9789301054525;4215.557366476599;4219.767912764827;4221.451211342629;6156.753729850756;6229.906551401823;6266.310705822265;6279.874402512016;6286.37136286386;6005.459508644243;6018.428249316308;6030.6080104793045;6034.63792172471;6034.668093254913;5969.552283578836;5991.430814072656;5995.27215117112;6008.1588577598295;6014.218151640259;5660.547156227574;5842.444967728059;5863.530917526673;5863.589548731547;5872.324682661549;6020.87958240824;6056.878862422815;6065.696715164136;6067.969660151847;6071.605345652519;5907.143464197581;5910.852228694317;5911.320198177093;5917.408259174048;5928.288605367211 04:19:15 INFO - PROCESS | 25379 | |5;yui.html;676.8713944350574;679.4530403025568;759.0739298056372;782.0966783365211;795.8845967334732;11278.718032049203;11388.316700997946;11405.14461415393;11416.714582135452;11474.311541307507;12611.43248553815;12724.745505089915;12759.36203189839;12808.807867881966;12826.230426174436;774.0711146624045;781.316348195329;794.6940427935228;794.6940427935258;795.8607243732324;781.4178437064395;782.460102529253;783.9294463498284;786.5752493653421;788.0582703669118;820.2207902492626;823.5141266652673;825.0099880143821;825.3232349473434;828.2214718164936;802.4102284820681;809.8339840332748;810.0562844286429;811.9878201826978;815.5799763121997;602.1599868183858;604.2326245668021;606.0394275074013;607.5959486941179;608.6287364707525;12044.81932771009;12073.27560346382;12081.939590301992;12090.516379344816;12107.455164517618;11729.178957472981;12000.819987700192;12007.264499225921;12054.216475929124;12075;9160.404573702688;9182.586783594754;9226.400283981588;9229.307801914816;9233.169014788702;3245.853936572836;3307.1566750478714;3314.5028245763087;3314.5193946877807;3400.2349471368993;41011;41271;41322.93235707827;41468.58531414707;41691.1661766763;8933.821323573622;9688.598519314;9815.852762208573;9866.605335786488;9870.654527091518;16348.509544713677;16364;16470.75293870593;16502.587435313973;16504.75242871358;6702.09521714572;6828.556143850733;6850.38346548813;6878.140232470942;7099.822504437327;3642.85428582859;3645.799481028569;3651.2514934438377;3682.705383569308;3739.102615372291;2684.463107378532;2703.635009273762;2711.444153948436;2715.3890374665543;2718.497078040569;497.6740235145985;504.02722745102307;506.5010964200333;507.2796628787131;512.1191550533077;495.8388523729802;555.6721534294785;563.8533981164927;567.6168586204295;595.8838026584774;7523.8495230095095;7533.660985255677;7612.961935190399;7831.569263690438;7844.4901081429525;479.4749749024812;562.7945799783132;565.926429564154;567.6792612174108;576.469647923911;3364.5962484502015;3445.594956892949;3465.833853841349;3545.2732189901008;3589.10272431892;45362.31956520655;45624;45869.5413045872;45938.77030614892;46396;41472.792636036625;42102.789486052374;42366.36450453246;42437.36343954843;42497;36152.63847361493;36820.63179368225;38039.61960380361;38379.424308635396;38442.615573844465;6703.4302084321425;6834.487413443912;6870.7595234166565;6962.338577835098;7126.2873712628325;28591.997120403576;29000.854995724887;29439.705602944552;29447.85276073606;30602;35426.46860297046;35987.64012359843;36032.63967360293;36079.098022549646;36144.45783313305;9740.707778766648;9982.550785214828;9992.350497217658;10061.547230374797;10094.343867648578;10647.094996925349;11102.888971110186;11400.201985860911;11413.029892459233;11414.94292528532;9151;9166;9189.77025574366;9274.304427167854;9325.906740932503;10359;10757.892421075689;10763.51564179598;10861.076808471053;11036.11711063129;9351.532423378667;9611.279154063333;9691.951540242535;9847.572102045307;10148.188144948239;8290.170982901662;8552.144785521647;8673.869891951752;8688;8856.690015849414;7796.337311328601;8249.463784853966;8386.538740369338;8464.238218560358;8721.127887211229 04:19:15 INFO - PROCESS | 25379 | __end_tp_report 04:19:15 INFO - PROCESS | 25379 | __start_cc_report 04:19:15 INFO - PROCESS | 25379 | _x_x_mozilla_cycle_collect,331 04:19:15 INFO - PROCESS | 25379 | __end_cc_report 04:19:15 INFO - PROCESS | 25379 | __startTimestamp1452601155116__endTimestamp 04:19:15 INFO - PROCESS | 25379 | 04:19:15 INFO - PROCESS | 25379 | ------- Summary: start ------- 04:19:15 INFO - PROCESS | 25379 | Number of tests: 6 04:19:15 INFO - PROCESS | 25379 | 04:19:15 INFO - PROCESS | 25379 | [#0] dojo.html Cycles:165 Average:4470.50 Median:4633.47 stddev:591.78 (12.8%) stddev-sans-first:575.63 04:19:15 INFO - PROCESS | 25379 | Values: 2625.5 2640.9 2667.0 2673.7 2679.7 4419.2 4518.5 4531.3 4575.7 4612.3 4446.9 4461.5 4528.3 4541.2 4588.6 21.0 4224.4 4227.6 4254.1 4327.5 4013.2 4102.3 4155.8 4160.3 4203.1 4234.7 4243.6 4246.8 4257.5 4280.1 4213.0 4243.4 4251.3 4258.4 4303.9 4091.1 4145.7 4156.4 4163.0 4165.2 4479.4 4482.3 4494.4 4507.9 4537.8 4889.4 4917.7 4922.6 4932.5 4971.6 4749.5 4824.4 4860.6 4941.9 4946.1 4583.5 4602.1 4603.1 4615.3 4630.5 4968.3 4985.8 5017.5 5029.7 5066.2 4746.9 4772.0 4814.8 4853.6 4855.9 4895.4 4924.9 4940.5 4943.8 4986.0 4859.1 4867.2 4889.8 4892.4 4928.5 4695.9 4752.6 4766.8 4816.3 4849.9 3800.7 3806.3 3810.5 3839.3 3853.4 3327.6 3424.6 3436.7 3461.8 3476.8 4180.9 4240.9 4261.7 4280.7 4298.8 4764.8 4766.7 4815.3 4816.1 4855.9 4178.0 4193.1 4194.8 4208.4 4243.4 4341.8 4408.9 4415.2 4422.2 4428.7 4621.9 4627.7 4675.5 4690.7 4730.6 4760.8 4815.3 4892.0 4901.9 4911.9 4697.5 4701.3 4707.3 4710.1 4721.6 4856.2 4870.8 4887.8 4895.4 4914.2 4717.2 4811.1 4830.6 4913.3 4919.5 4700.2 4714.2 4740.2 4756.3 4783.3 4678.0 4723.1 4729.9 4735.8 4781.7 4600.5 4611.6 4645.4 4674.6 4679.7 4688.2 4697.6 4709.5 4722.1 4751.7 4569.6 4618.1 4621.8 4633.5 4663.7 04:19:15 INFO - PROCESS | 25379 | 04:19:15 INFO - PROCESS | 25379 | [#1] ext.html Cycles:180 Average:39950.53 Median:33234.50 stddev:63939.34 (192.4%) stddev-sans-first:64050.03 04:19:15 INFO - PROCESS | 25379 | Values: 482.0 485.6 490.2 504.1 518.7 32166.4 32727.8 32768.0 32774.7 32802.3 35798.6 36563.8 36661.0 36699.8 36753.8 7636.8 7732.3 7773.8 7779.1 7791.1 7560.0 7649.8 7676.0 7684.6 7721.8 7779.6 7850.3 7860.3 7912.9 7916.6 7703.6 7811.0 7822.1 7831.7 7850.9 7552.9 7604.1 7611.7 7659.2 7670.1 36869.0 37224.3 37351.8 37387.6 37428.6 2365.3 2819.2 2922.9 3029.3 3071.1 24425.6 28096.0 28842.6 28853.0 28958.1 3178.6 3198.5 3207.2 3218.2 3276.6 166823.2 168513.0 168959.0 169362.0 169496.0 46517.3 50004.5 50111.5 50193.2 50341.7 40070.4 59840.0 60622.9 60673.4 60678.0 13623.3 13665.9 13694.7 13813.8 13831.2 10437.0 10523.5 10539.5 10548.5 10629.1 18239.8 18399.9 18619.3 18643.5 18668.8 6640.7 6818.4 6841.1 6889.4 6982.5 827.9 888.6 902.3 994.8 1013.7 23836.9 23939.6 24009.6 24062.5 24307.3 909.7 934.5 988.7 988.9 998.1 13075.3 15084.8 15188.9 15212.5 15438.8 304410.0 308244.0 309668.0 311051.0 311865.0 47768.0 48284.0 48334.0 48486.8 48533.5 1197.4 1216.4 1234.1 1245.8 1247.8 27475.3 28063.4 28147.3 28334.9 30546.4 42762.8 43376.1 43398.8 43401.3 43551.3 232598.0 235284.0 235405.0 235599.0 235762.0 32002.7 32669.7 37098.0 38082.6 39122.2 34490.7 38196.4 38370.8 39211.8 39274.8 32721.0 33205.2 33873.5 34025.7 34138.3 32733.3 32834.8 33548.2 33789.8 33835.0 32563.5 33122.7 33191.8 33224.3 33244.7 28348.0 29944.0 29979.3 30309.1 30510.2 24623.0 25064.4 25208.5 25341.7 25482.5 04:19:15 INFO - PROCESS | 25379 | 04:19:15 INFO - PROCESS | 25379 | [#2] jquery.html Cycles:180 Average:23967.37 Median:4939.70 stddev:74312.68 (1504.4%) stddev-sans-first:74499.95 04:19:15 INFO - PROCESS | 25379 | Values: 332.7 338.3 340.0 343.9 346.9 11939.5 12357.6 14484.4 14604.0 16386.1 9905.7 10230.4 10240.3 14924.9 15527.8 4496.3 4635.5 4641.9 4646.4 4649.1 4888.5 4957.8 4972.1 4978.4 4979.9 4787.0 4959.9 4969.3 4984.1 4984.9 4921.7 4970.6 4971.2 4975.3 4982.7 4331.9 4416.3 4471.5 4487.1 4509.1 17811.7 18139.0 18366.4 18473.0 18567.9 1823.1 1878.4 1919.1 1922.8 1930.0 9031.3 9076.6 9270.0 10244.4 12388.8 1718.0 1766.2 1770.6 1781.0 1781.1 48835.5 48962.8 49934.8 50465.5 50798.2 9624.0 9649.1 9800.9 9833.4 9869.2 12422.8 12522.8 21034.4 21113.6 21604.5 8028.5 8039.6 8039.8 8075.0 8294.5 6313.8 6517.6 6838.2 6868.8 7350.7 7220.3 7232.9 7263.8 7301.2 7411.3 2988.8 3043.4 3052.9 3112.9 3202.6 794.8 822.9 836.8 884.7 925.4 14595.9 14985.3 15457.5 15749.6 15810.2 889.0 894.1 902.2 920.9 956.8 8903.7 8977.6 8985.4 9146.6 9251.3 447228.0 448713.0 455923.0 459517.0 463723.0 65278.0 65606.7 65879.7 65982.0 66524.0 1092.1 1102.4 1140.5 1173.4 1174.3 13049.0 13198.6 13598.2 14017.9 14126.4 27634.3 27737.2 28027.4 28919.6 29233.4 32173.5 33254.3 35363.1 37373.6 37832.0 6412.5 6576.8 6754.6 6794.1 6888.1 9014.3 9957.8 10261.6 10418.5 10561.5 7238.8 7253.6 7980.4 8027.7 8444.5 8180.6 8308.6 8431.9 8496.8 8531.9 2575.5 2588.1 5014.3 7060.8 8384.8 6623.8 6841.5 6846.4 6902.2 6904.4 6765.3 7776.2 8213.8 8274.5 8336.5 04:19:15 INFO - PROCESS | 25379 | 04:19:15 INFO - PROCESS | 25379 | [#3] mootools.html Cycles:180 Average:5145.73 Median:6294.37 stddev:2656.28 (42.2%) stddev-sans-first:2648.72 04:19:15 INFO - PROCESS | 25379 | Values: 1388.2 1393.5 1504.7 1677.0 1699.0 6298.5 6495.2 7275.3 7474.1 7496.4 6976.0 7060.8 7203.6 7216.3 7227.8 2159.3 2209.3 2209.9 2209.9 2213.0 2074.8 2081.2 2149.7 2152.4 2161.4 2144.5 2149.7 2160.2 2161.0 2206.1 2191.8 2191.8 2202.8 2204.7 2205.6 2160.4 2200.3 2202.8 2206.1 2206.4 7551.2 7591.1 7604.3 7655.1 7658.2 4248.6 4344.1 4369.3 4390.7 4404.6 2284.8 2357.5 2702.5 2756.0 2765.3 815.2 829.2 835.1 835.5 849.8 10124.9 10140.9 10147.0 10158.6 10182.3 4144.1 4154.8 4234.6 4238.8 4249.7 8928.6 8947.2 8959.3 8972.1 8984.7 4541.3 4572.8 4578.4 4584.3 4599.3 4097.0 4109.6 4134.0 4161.1 4161.8 3485.6 3489.0 3493.3 3534.1 3552.1 1148.1 1151.9 1153.0 1157.8 1160.5 916.0 939.6 1157.0 1164.1 1172.3 6592.5 6632.7 6643.3 6659.6 6680.1 1013.5 1038.3 1044.5 1045.0 1083.5 5020.3 5038.2 5039.8 5046.0 5077.1 7841.0 8299.4 8732.7 8773.1 8809.3 8551.1 8576.0 8593.0 8619.6 8627.4 6606.7 6744.9 6804.4 6911.5 7007.6 6749.8 6815.9 6821.5 6853.5 6855.3 7579.9 7754.3 7800.1 7881.6 7890.1 7730.6 7903.1 7961.9 7967.6 7968.7 6055.4 6138.1 6165.1 6170.1 6190.6 6930.0 7080.5 7084.0 7104.9 7108.0 6668.1 6683.0 6750.3 6801.2 6836.6 6726.8 6740.2 6829.2 6850.1 6884.7 6887.0 6958.8 6960.1 6967.4 6975.5 6121.0 6275.7 6290.2 6305.8 6312.3 6409.7 6425.8 6470.4 6471.5 6485.8 04:19:15 INFO - PROCESS | 25379 | 04:19:15 INFO - PROCESS | 25379 | [#4] prototype.html Cycles:180 Average:4935.39 Median:5627.99 stddev:1480.97 (26.3%) stddev-sans-first:1443.90 04:19:15 INFO - PROCESS | 25379 | Values: 312.3 315.6 319.0 320.5 328.1 5569.2 5680.8 5784.5 5787.8 5804.0 5612.9 5643.1 5678.3 5680.1 5683.0 4191.5 4297.8 4301.2 4302.0 4332.7 4293.0 4311.4 4328.7 4335.4 4343.8 4287.2 4302.7 4308.1 4309.9 4317.5 4303.3 4306.2 4307.8 4316.7 4319.9 3632.7 3734.6 3735.8 3738.9 3744.3 5287.0 5447.6 5451.6 5451.9 5454.3 4922.3 4943.5 4948.3 4955.6 4965.7 5938.7 5941.0 5945.2 5959.9 5960.5 3938.4 4062.7 4064.5 4082.3 4084.2 6202.9 6209.1 6280.1 6281.7 6290.2 4173.8 4180.6 4195.0 4196.4 4198.2 4237.4 4251.7 4258.3 4270.0 4280.3 4737.1 4792.0 4852.8 4899.2 4916.1 5898.1 5939.6 5947.3 5985.6 5986.5 1488.0 1515.9 1521.9 1522.6 1524.2 958.5 1005.4 1018.2 1022.0 1023.2 5142.1 5185.3 5205.7 5210.9 5216.5 6124.9 6133.9 6150.3 6151.1 6184.3 5161.6 5166.5 5201.8 5206.4 5209.7 3267.3 3335.5 3352.1 3381.2 3405.2 5832.1 5843.0 5872.9 5876.7 5885.3 6455.3 6475.0 6478.6 6489.6 6495.4 5710.9 5892.6 5899.1 5906.7 5922.0 6278.7 6286.2 6293.5 6302.1 6302.8 6106.8 6114.3 6140.5 6140.7 6147.7 5779.3 5888.4 5907.8 5919.2 5922.5 4171.3 4214.0 4215.6 4219.8 4221.5 6156.8 6229.9 6266.3 6279.9 6286.4 6005.5 6018.4 6030.6 6034.6 6034.7 5969.6 5991.4 5995.3 6008.2 6014.2 5660.5 5842.4 5863.5 5863.6 5872.3 6020.9 6056.9 6065.7 6068.0 6071.6 5907.1 5910.9 5911.3 5917.4 5928.3 04:19:15 INFO - PROCESS | 25379 | 04:19:15 INFO - PROCESS | 25379 | [#5] yui.html Cycles:180 Average:11787.48 Median:500.85 stddev:13003.02 (2596.2%) stddev-sans-first:13012.72 04:19:15 INFO - PROCESS | 25379 | Values: 676.9 679.5 759.1 782.1 795.9 11278.7 11388.3 11405.1 11416.7 11474.3 12611.4 12724.7 12759.4 12808.8 12826.2 774.1 781.3 794.7 794.7 795.9 781.4 782.5 783.9 786.6 788.1 820.2 823.5 825.0 825.3 828.2 802.4 809.8 810.1 812.0 815.6 602.2 604.2 606.0 607.6 608.6 12044.8 12073.3 12081.9 12090.5 12107.5 11729.2 12000.8 12007.3 12054.2 12075.0 9160.4 9182.6 9226.4 9229.3 9233.2 3245.9 3307.2 3314.5 3314.5 3400.2 41011.0 41271.0 41322.9 41468.6 41691.2 8933.8 9688.6 9815.9 9866.6 9870.7 16348.5 16364.0 16470.8 16502.6 16504.8 6702.1 6828.6 6850.4 6878.1 7099.8 3642.9 3645.8 3651.3 3682.7 3739.1 2684.5 2703.6 2711.4 2715.4 2718.5 497.7 504.0 506.5 507.3 512.1 495.8 555.7 563.9 567.6 595.9 7523.8 7533.7 7613.0 7831.6 7844.5 479.5 562.8 565.9 567.7 576.5 3364.6 3445.6 3465.8 3545.3 3589.1 45362.3 45624.0 45869.5 45938.8 46396.0 41472.8 42102.8 42366.4 42437.4 42497.0 36152.6 36820.6 38039.6 38379.4 38442.6 6703.4 6834.5 6870.8 6962.3 7126.3 28592.0 29000.9 29439.7 29447.9 30602.0 35426.5 35987.6 36032.6 36079.1 36144.5 9740.7 9982.6 9992.4 10061.5 10094.3 10647.1 11102.9 11400.2 11413.0 11414.9 9151.0 9166.0 9189.8 9274.3 9325.9 10359.0 10757.9 10763.5 10861.1 11036.1 9351.5 9611.3 9692.0 9847.6 10148.2 8290.2 8552.1 8673.9 8688.0 8856.7 7796.3 8249.5 8386.5 8464.2 8721.1 04:19:15 INFO - PROCESS | 25379 | -------- Summary: end -------- 04:19:15 INFO - PROCESS | 25379 | 04:19:15 INFO - TEST-INFO | 25379: exit 0 04:19:15 INFO - TEST-OK | dromaeo_css | took 1113883ms 04:19:15 INFO - TEST-START | kraken 04:19:15 INFO - operating with platform_type : linux_ 04:19:15 INFO - Initialising browser for kraken test... 04:19:15 INFO - TEST-INFO | started process 25619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpID9cHn/profile http://localhost:59471/getInfo.html) 04:19:19 INFO - PROCESS | 25619 | 04:19:19 INFO - PROCESS | 25619 | (process:25690): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:20 INFO - PROCESS | 25619 | __metrics Screen width/height:1600/1200 04:19:20 INFO - PROCESS | 25619 | colorDepth:24 04:19:20 INFO - PROCESS | 25619 | Browser inner width/height: 1024/697 04:19:20 INFO - PROCESS | 25619 | __metrics 04:19:20 INFO - PROCESS | 25619 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:19:21 INFO - TEST-INFO | 25619: exit 0 04:19:21 INFO - Browser initialized. 04:19:21 INFO - Running cycle 1/1 for kraken test... 04:19:21 INFO - TEST-INFO | started process 25739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpID9cHn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:22 INFO - PROCESS | 25739 | 04:19:22 INFO - PROCESS | 25739 | (process:25797): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:33 INFO - PROCESS | 25739 | RSS: Main: 150437888 04:19:33 INFO - PROCESS | 25739 | 04:19:36 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59471/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:36 INFO - PROCESS | 25739 | RSS: Main: 150306816 04:19:36 INFO - PROCESS | 25739 | 04:19:39 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59471/tests/kraken/driver.html?testName=audio-dft) 04:19:40 INFO - PROCESS | 25739 | RSS: Main: 151248896 04:19:40 INFO - PROCESS | 25739 | 04:19:42 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59471/tests/kraken/driver.html?testName=audio-fft) 04:19:43 INFO - PROCESS | 25739 | RSS: Main: 147251200 04:19:43 INFO - PROCESS | 25739 | 04:19:45 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59471/tests/kraken/driver.html?testName=audio-oscillator) 04:19:46 INFO - PROCESS | 25739 | RSS: Main: 147419136 04:19:46 INFO - PROCESS | 25739 | 04:19:48 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:49 INFO - PROCESS | 25739 | RSS: Main: 147275776 04:19:49 INFO - PROCESS | 25739 | 04:19:52 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59471/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:52 INFO - PROCESS | 25739 | RSS: Main: 146173952 04:19:52 INFO - PROCESS | 25739 | 04:19:56 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59471/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:57 INFO - PROCESS | 25739 | RSS: Main: 145342464 04:19:57 INFO - PROCESS | 25739 | 04:19:59 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59471/tests/kraken/driver.html?testName=json-parse-financial) 04:20:00 INFO - PROCESS | 25739 | RSS: Main: 146448384 04:20:00 INFO - PROCESS | 25739 | 04:20:02 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:02 INFO - PROCESS | 25739 | RSS: Main: 147738624 04:20:02 INFO - PROCESS | 25739 | 04:20:04 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59471/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:05 INFO - PROCESS | 25739 | RSS: Main: 148262912 04:20:05 INFO - PROCESS | 25739 | 04:20:07 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:08 INFO - PROCESS | 25739 | RSS: Main: 148725760 04:20:08 INFO - PROCESS | 25739 | 04:20:10 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:11 INFO - PROCESS | 25739 | RSS: Main: 148750336 04:20:11 INFO - PROCESS | 25739 | 04:20:13 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:14 INFO - PROCESS | 25739 | RSS: Main: 148578304 04:20:14 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | Cycle 1(1): loaded http://localhost:59471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59471/tests/kraken/driver.html?testName=ai-astar) 04:20:16 INFO - PROCESS | 25739 | RSS: Main: 149082112 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | __start_tp_report 04:20:16 INFO - PROCESS | 25739 | _x_x_mozilla_page_load 04:20:16 INFO - PROCESS | 25739 | _x_x_mozilla_page_load_details 04:20:16 INFO - PROCESS | 25739 | |i|pagename|runs| 04:20:16 INFO - PROCESS | 25739 | |0;ai-astar;114;110;115;115;115;125;116;115;113;116 04:20:16 INFO - PROCESS | 25739 | |1;audio-beat-detection;162;138;155;171;141;157;166;140;174;142 04:20:16 INFO - PROCESS | 25739 | |2;audio-dft;163;163;164;163;164;167;171;163;166;163 04:20:16 INFO - PROCESS | 25739 | |3;audio-fft;73;77;74;158;74;75;73;74;150;73 04:20:16 INFO - PROCESS | 25739 | |4;audio-oscillator;99;100;149;96;96;97;148;98;98;135 04:20:16 INFO - PROCESS | 25739 | |5;imaging-gaussian-blur;110;110;110;111;110;110;110;111;115;110 04:20:16 INFO - PROCESS | 25739 | |6;imaging-darkroom;149;148;147;148;151;148;147;149;149;158 04:20:16 INFO - PROCESS | 25739 | |7;imaging-desaturate;96;97;96;96;96;96;96;98;96;96 04:20:16 INFO - PROCESS | 25739 | |8;json-parse-financial;71;70;69;70;71;71;69;77;68;69 04:20:16 INFO - PROCESS | 25739 | |9;json-stringify-tinderbox;68;68;69;68;67;68;67;67;69;67 04:20:16 INFO - PROCESS | 25739 | |10;stanford-crypto-aes;80;84;85;84;83;83;84;83;84;83 04:20:16 INFO - PROCESS | 25739 | |11;stanford-crypto-ccm;124;119;126;136;122;125;123;124;129;135 04:20:16 INFO - PROCESS | 25739 | |12;stanford-crypto-pbkdf2;140;150;151;163;147;136;148;146;147;135 04:20:16 INFO - PROCESS | 25739 | |13;stanford-crypto-sha256-iterative;72;70;70;72;72;71;70;72;72;71 04:20:16 INFO - PROCESS | 25739 | __end_tp_report 04:20:16 INFO - PROCESS | 25739 | __start_cc_report 04:20:16 INFO - PROCESS | 25739 | _x_x_mozilla_cycle_collect,799 04:20:16 INFO - PROCESS | 25739 | __end_cc_report 04:20:16 INFO - PROCESS | 25739 | __startTimestamp1452601216491__endTimestamp 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | ------- Summary: start ------- 04:20:16 INFO - PROCESS | 25739 | Number of tests: 14 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:3.81 (3.3%) stddev-sans-first:4.00 04:20:16 INFO - PROCESS | 25739 | Values: 114.0 110.0 115.0 115.0 115.0 125.0 116.0 115.0 113.0 116.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:159.50 stddev:13.62 (8.5%) stddev-sans-first:14.18 04:20:16 INFO - PROCESS | 25739 | Values: 162.0 138.0 155.0 171.0 141.0 157.0 166.0 140.0 174.0 142.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:2.63 (1.6%) stddev-sans-first:2.71 04:20:16 INFO - PROCESS | 25739 | Values: 163.0 163.0 164.0 163.0 164.0 167.0 171.0 163.0 166.0 163.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#3] audio-fft Cycles:10 Average:90.10 Median:74.00 stddev:33.75 (45.6%) stddev-sans-first:35.23 04:20:16 INFO - PROCESS | 25739 | Values: 73.0 77.0 74.0 158.0 74.0 75.0 73.0 74.0 150.0 73.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:96.50 stddev:22.69 (23.5%) stddev-sans-first:23.61 04:20:16 INFO - PROCESS | 25739 | Values: 99.0 100.0 149.0 96.0 96.0 97.0 148.0 98.0 98.0 135.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:110.00 stddev:1.57 (1.4%) stddev-sans-first:1.64 04:20:16 INFO - PROCESS | 25739 | Values: 110.0 110.0 110.0 111.0 110.0 110.0 110.0 111.0 115.0 110.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.00 stddev:3.24 (2.2%) stddev-sans-first:3.43 04:20:16 INFO - PROCESS | 25739 | Values: 149.0 148.0 147.0 148.0 151.0 148.0 147.0 149.0 149.0 158.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:20:16 INFO - PROCESS | 25739 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#8] json-parse-financial Cycles:10 Average:70.50 Median:70.50 stddev:2.51 (3.6%) stddev-sans-first:2.65 04:20:16 INFO - PROCESS | 25739 | Values: 71.0 70.0 69.0 70.0 71.0 71.0 69.0 77.0 68.0 69.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 04:20:16 INFO - PROCESS | 25739 | Values: 68.0 68.0 69.0 68.0 67.0 68.0 67.0 67.0 69.0 67.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:1.34 (1.6%) stddev-sans-first:0.71 04:20:16 INFO - PROCESS | 25739 | Values: 80.0 84.0 85.0 84.0 83.0 83.0 84.0 83.0 84.0 83.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:125.50 stddev:5.50 (4.4%) stddev-sans-first:5.77 04:20:16 INFO - PROCESS | 25739 | Values: 124.0 119.0 126.0 136.0 122.0 125.0 123.0 124.0 129.0 135.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:147.50 stddev:8.11 (5.5%) stddev-sans-first:8.28 04:20:16 INFO - PROCESS | 25739 | Values: 140.0 150.0 151.0 163.0 147.0 136.0 148.0 146.0 147.0 135.0 04:20:16 INFO - PROCESS | 25739 | 04:20:16 INFO - PROCESS | 25739 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:72.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 04:20:16 INFO - PROCESS | 25739 | Values: 72.0 70.0 70.0 72.0 72.0 71.0 70.0 72.0 72.0 71.0 04:20:16 INFO - PROCESS | 25739 | -------- Summary: end -------- 04:20:16 INFO - PROCESS | 25739 | 04:20:17 INFO - TEST-INFO | 25739: exit 0 04:20:17 INFO - TEST-OK | kraken | took 61714ms 04:20:17 INFO - TEST-START | v8_7 04:20:17 INFO - operating with platform_type : linux_ 04:20:17 INFO - Initialising browser for v8_7 test... 04:20:17 INFO - TEST-INFO | started process 26026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkKcAqn/profile http://localhost:59471/getInfo.html) 04:20:21 INFO - PROCESS | 26026 | 04:20:21 INFO - PROCESS | 26026 | (process:26097): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:20:22 INFO - PROCESS | 26026 | __metrics Screen width/height:1600/1200 04:20:22 INFO - PROCESS | 26026 | colorDepth:24 04:20:22 INFO - PROCESS | 26026 | Browser inner width/height: 1024/697 04:20:22 INFO - PROCESS | 26026 | __metrics 04:20:22 INFO - PROCESS | 26026 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:20:23 INFO - TEST-INFO | 26026: exit 0 04:20:23 INFO - Browser initialized. 04:20:23 INFO - Running cycle 1/1 for v8_7 test... 04:20:23 INFO - TEST-INFO | started process 26147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkKcAqn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:24 INFO - PROCESS | 26147 | 04:20:24 INFO - PROCESS | 26147 | (process:26205): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:20:35 INFO - PROCESS | 26147 | RSS: Main: 150020096 04:20:35 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | Cycle 1(1): loaded http://localhost:59471/tests/v8_7/run.html (next: http://localhost:59471/tests/v8_7/run.html) 04:20:57 INFO - PROCESS | 26147 | RSS: Main: 145629184 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | __start_tp_report 04:20:57 INFO - PROCESS | 26147 | _x_x_mozilla_page_load 04:20:57 INFO - PROCESS | 26147 | _x_x_mozilla_page_load_details 04:20:57 INFO - PROCESS | 26147 | |i|pagename|runs| 04:20:57 INFO - PROCESS | 26147 | |0;Richards;167.19612104999163 04:20:57 INFO - PROCESS | 26147 | |1;DeltaBlue;187.93459875963165 04:20:57 INFO - PROCESS | 26147 | |2;Encrypt;278.6291446085261 04:20:57 INFO - PROCESS | 26147 | |3;Decrypt;5229.166666666667 04:20:57 INFO - PROCESS | 26147 | |4;RayTrace;1082.2510822510822 04:20:57 INFO - PROCESS | 26147 | |5;Earley;721.7015140591204 04:20:57 INFO - PROCESS | 26147 | |6;Boyer;12884.615384615385 04:20:57 INFO - PROCESS | 26147 | |7;RegExp;43382.97872340425 04:20:57 INFO - PROCESS | 26147 | |8;Splay;591.3660555884093 04:20:57 INFO - PROCESS | 26147 | |9;NavierStokes;4830.917874396136 04:20:57 INFO - PROCESS | 26147 | __end_tp_report 04:20:57 INFO - PROCESS | 26147 | __startTimestamp1452601257939__endTimestamp 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | ------- Summary: start ------- 04:20:57 INFO - PROCESS | 26147 | Number of tests: 10 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#0] Richards Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 167.2 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#1] DeltaBlue Cycles:1 Average:187.93 Median:187.93 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 187.9 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 278.6 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 5229.2 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#4] RayTrace Cycles:1 Average:1082.25 Median:1082.25 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 1082.3 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#5] Earley Cycles:1 Average:721.70 Median:721.70 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 721.7 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#6] Boyer Cycles:1 Average:12884.62 Median:12884.62 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 12884.6 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#7] RegExp Cycles:1 Average:43382.98 Median:43382.98 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 43383.0 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#8] Splay Cycles:1 Average:591.37 Median:591.37 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 591.4 04:20:57 INFO - PROCESS | 26147 | 04:20:57 INFO - PROCESS | 26147 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:20:57 INFO - PROCESS | 26147 | Values: 4830.9 04:20:57 INFO - PROCESS | 26147 | -------- Summary: end -------- 04:20:57 INFO - PROCESS | 26147 | 04:20:58 INFO - TEST-INFO | 26147: exit 0 04:20:58 INFO - TEST-OK | v8_7 | took 41346ms 04:20:58 INFO - SUITE-END | took 1216s 04:20:58 INFO - Completed test suite (00:20:17) 04:20:58 INFO - Working with test: dromaeo_css 04:20:58 INFO - Generating results file: dromaeo_css 04:20:58 INFO - Working with test: kraken 04:20:58 INFO - Generating results file: kraken 04:20:58 INFO - javascript benchmark 04:20:58 INFO - Working with test: v8_7 04:20:58 INFO - Generating results file: v8_7 04:20:58 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:20:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:20:58 INFO - process_Request line: dromaeo_css 6244.76 graph.html#tests=[[72,94,43]] 04:20:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:20:59 INFO - process_Request line: kraken 1558.20 graph.html#tests=[[232,94,43]] 04:20:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:20:59 INFO - process_Request line: v8_7 20162.90 graph.html#tests=[[230,94,43]] 04:20:59 INFO - RETURN: dromaeo_css: 6244.76 04:20:59 INFO - RETURN: kraken: 1558.20 04:20:59 INFO - RETURN: v8_7: 20162.90 04:20:59 INFO - javascript benchmark 04:20:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2625.461780335031, 2640.9339766505846, 2667.0265353146096, 2673.7459941305583, 2679.705232424433, 4419.226635338819, 4518.457785065792, 4531.297648864423, 4575.748333841638, 4612.285095810146, 4446.866594002185, 4461.464624245087, 4528.275475923853, 4541.227991241489, 4588.632909367251, 20.993349792582222, 4224.387463817737, 4227.577242275778, 4254.127903779718, 4327.545607711192, 4013.1572369802375, 4102.323116685759, 4155.750654960712, 4160.271952408331, 4203.117345357463, 4234.68239882007, 4243.596858298472, 4246.830126794925, 4257.489101307848, 4280.122574872144, 4213.0, 4243.363495475673, 4251.27728286189, 4258.42511260982, 4303.892402689927, 4091.1408604193157, 4145.730527515732, 4156.376543518466, 4162.958370416318, 4165.208610364021, 4479.440069991251, 4482.260427029536, 4494.415725955605, 4507.909841803145, 4537.795799189044, 4889.4377146627885, 4917.72952487613, 4922.606191504707, 4932.457429682732, 4971.602271818246, 4749.525047495257, 4824.396950381202, 4860.562549370538, 4941.925871111936, 4946.109700253953, 4583.462063604384, 4602.05657840142, 4603.10239503297, 4615.284630882219, 4630.536946305342, 4968.30443737877, 4985.825496107619, 5017.523335283142, 5029.748512574357, 5066.240063990357, 4746.905061898743, 4772.045590881838, 4814.831480898151, 4853.563179313879, 4855.902881942341, 4895.412550493964, 4924.8768780780765, 4940.49783560568, 4943.826966056171, 4985.9501404985485, 4859.125357435695, 4867.245576935581, 4889.779959901813, 4892.437369702458, 4928.48250933654, 4695.882602934954, 4752.572268495852, 4766.785494652749, 4816.325714399987, 4849.878753031202, 3800.733948623625, 3806.2577797329254, 3810.504634397566, 3839.308924393636, 3853.402722578005, 3327.617324007722, 3424.5890493140982, 3436.6563343665935, 3461.7576769625884, 3476.8435420406145, 4180.874573762792, 4240.851570195028, 4261.680373971903, 4280.6789490788315, 4298.763568003727, 4764.809407623726, 4766.6901651392545, 4815.281024595845, 4816.060868130681, 4855.902881942341, 4177.958220417818, 4193.056562273464, 4194.769287689206, 4208.431861698631, 4243.405923170759, 4341.826326946887, 4408.933865992013, 4415.183191109655, 4422.248217802981, 4428.6678499112695, 4621.907561848677, 4627.699199552018, 4675.485696573374, 4690.671652984327, 4730.574248317736, 4760.833370832004, 4815.253635686474, 4891.95108048915, 4901.9264711028645, 4911.926321105115, 4697.483276839476, 4701.294805779161, 4707.2939059140035, 4710.105080034782, 4721.598664113589, 4856.247281671205, 4870.805167793249, 4887.780049897692, 4895.4370247422, 4914.238293064581, 4717.198076327101, 4811.061842940593, 4830.637702172281, 4913.287573301923, 4919.483454237254, 4700.153972285021, 4714.222153344797, 4740.170470167775, 4756.286557016475, 4783.330333753347, 4678.041001594733, 4723.149833030087, 4729.881752956066, 4735.763211839463, 4781.665283430127, 4600.539946005507, 4611.5619016193405, 4645.419322584677, 4674.649401294849, 4679.672422930362, 4688.226442637063, 4697.553732395417, 4709.481956984798, 4722.1028004679, 4751.667383283137, 4569.611583015481, 4618.053299073615, 4621.768911554476, 4633.467151277646, 4663.696859704109], "unit": "score", "name": "dojo.html", "value": 4435.992472099972}, {"lowerIsBetter": false, "replicates": [481.9903601927962, 485.5702703107749, 490.24012780190674, 504.1278588042686, 518.6913786297151, 32166.356672866557, 32727.836360818193, 32768.0, 32774.67225327749, 32802.34395312092, 35798.64201357992, 36563.81718091413, 36661.0, 36699.81650091753, 36753.816230918805, 7636.809079773008, 7732.304092631662, 7773.844523109535, 7779.105402878657, 7791.142974272825, 7560.0, 7649.808754781119, 7676.040494938133, 7684.615769211545, 7721.806954826118, 7779.572123533203, 7850.2542258485355, 7860.253275938777, 7912.881306780403, 7916.564588947605, 7703.576303303316, 7810.960945195295, 7822.061352637663, 7831.668616335237, 7850.882236766453, 7552.8867066994035, 7604.0875094988405, 7611.6574754135645, 7659.157492675801, 7670.0795904491815, 36869.0, 37224.255514889825, 37351.813240933894, 37387.626123738955, 37428.62571374306, 2365.29041287613, 2819.2388055224974, 2922.8684709187924, 3029.3184033592484, 3071.1247294520954, 24425.633615495783, 28096.0, 28842.567361489593, 28853.0, 28958.131256062352, 3178.55500229968, 3198.5362122492343, 3207.1661368044242, 3218.2115381731624, 3276.6231883333244, 166823.1658841698, 168513.0, 168959.0, 169362.0, 169496.0, 46517.30224046642, 50004.49995500071, 50111.49888501141, 50193.24710129351, 50341.74829125831, 40070.39894401586, 59840.0, 60622.878199262814, 60673.39326606766, 60678.0, 13623.318834058457, 13665.931670341784, 13694.657633559042, 13813.792793108112, 13831.239281839595, 10437.0, 10523.52644131016, 10539.525721342558, 10548.47257637115, 10629.149668026539, 18239.817601824077, 18399.908000459913, 18619.348322808637, 18643.533911652317, 18668.81331186698, 6640.734370625121, 6818.420434263143, 6841.110655614738, 6889.414399776075, 6982.546134501241, 827.8840962265288, 888.648983651454, 902.3232575568323, 994.8259054665405, 1013.6604237580493, 23836.88081559616, 23939.640905386434, 24009.639855402183, 24062.51874962526, 24307.27078187657, 909.6816114359921, 934.4580143516744, 988.658912675126, 988.8813342398959, 998.1266391907081, 13075.280859552626, 15084.773728394082, 15188.924055379874, 15212.46756363522, 15438.845611543966, 304410.0, 308244.0, 309668.0, 311051.0, 311865.0, 47768.0, 48284.0, 48334.0, 48486.75756621194, 48533.5146648536, 1197.437204513877, 1216.3639904328663, 1234.1422711215619, 1245.8131280308025, 1247.7629250442387, 27475.31311717223, 28063.43873122567, 28147.296317591405, 28334.858325709065, 30546.389072218877, 42762.78618606887, 43376.132477349645, 43398.78300608603, 43401.3489797647, 43551.34672979971, 232598.0, 235284.0, 235405.0, 235599.0, 235762.0, 32002.679973200902, 32669.673303267613, 37097.98354444339, 38082.61917380791, 39122.217555649295, 34490.655093448746, 38196.42705359477, 38370.80814595909, 39211.823645290686, 39274.80362598169, 32721.0, 33205.169870752456, 33873.49189762205, 34025.65974340225, 34138.31723365469, 32733.34533309273, 32834.835825820715, 33548.161295967795, 33789.83105084459, 33835.0, 32563.511547326336, 33122.66877331196, 33191.83404082964, 33224.33551329008, 33244.66755332416, 28348.0, 29944.0, 29979.255692247963, 30309.090727278217, 30510.237244069074, 24623.0, 25064.37339066538, 25208.495830083662, 25341.74658253394, 25482.490350192522], "unit": "score", "name": "ext.html", "value": 16607.63867206241}, {"lowerIsBetter": false, "replicates": [332.7005694874614, 338.2727136656189, 340.02921658664513, 343.92605589798194, 346.9271452994871, 11939.522419103225, 12357.629271121858, 14484.420623175074, 14604.0, 16386.098764567945, 9905.702828915126, 10230.43732594707, 10240.28318017739, 14924.925375373108, 15527.844721552781, 4496.325551167327, 4635.536446355354, 4641.93037104442, 4646.372739680134, 4649.139909116824, 4888.535589119028, 4957.752112394366, 4972.0801651694555, 4978.377702787152, 4979.875503112415, 4786.952130478703, 4959.900801983958, 4969.329140566031, 4984.127777638917, 4984.925226121611, 4921.655484116113, 4970.552650261494, 4971.179755340365, 4975.303457515951, 4982.725950072744, 4331.859401933604, 4416.33754936762, 4471.463424389061, 4487.147441986012, 4509.098180363941, 17811.73282400765, 18139.004709481946, 18366.449006529692, 18473.0, 18567.907160464245, 1823.0793449308146, 1878.4083013850593, 1919.078842155759, 1922.7596550431197, 1929.9710504342447, 9031.322650801216, 9076.636934522678, 9269.953650231773, 10244.436555989418, 12388.81416778749, 1717.9570510737205, 1766.240516577871, 1770.6104656975444, 1780.9545082272407, 1781.0649409060347, 48835.51164488345, 48962.75518622384, 49934.75032624813, 50465.495345046445, 50798.23802642963, 9624.0, 9649.083337082966, 9800.852987205197, 9833.4099954003, 9869.161121304769, 12422.819832115934, 12522.81215781764, 21034.368968930958, 21113.577728445653, 21604.4598885026, 8028.518288902685, 8039.598020098972, 8039.799005024921, 8074.959625201836, 8294.543800091053, 6313.779017734358, 6517.576357536745, 6838.21360543534, 6868.828279293058, 7350.669219885118, 7220.3140701633265, 7232.891506627405, 7263.782086537412, 7301.1968683444775, 7411.295926886937, 2988.7608991280645, 3043.3761078978755, 3052.923676908095, 3112.8754849806205, 3202.583664123649, 794.8092457810084, 822.942394032424, 836.761522965964, 884.6638277454655, 925.4262357338494, 14595.92702036483, 14985.250737463084, 15457.5362739118, 15749.606259843596, 15810.209489525478, 888.9733308000771, 894.1000374204815, 902.1970446302796, 920.8802855628859, 956.7608097975506, 8903.688370906988, 8977.640894364284, 8985.415947963362, 9146.588403521857, 9251.306152038624, 447228.0, 448713.0, 455923.0, 459517.0, 463723.0, 65278.0, 65606.67196663986, 65879.67060164764, 65982.0, 66524.0, 1092.1372116028408, 1102.366139469808, 1140.4696815980608, 1173.372245848467, 1174.3482367286067, 13049.0, 13198.60404187876, 13598.184108953494, 14017.859821402064, 14126.364313606118, 27634.309142271602, 27737.167884963485, 28027.43945121127, 28919.566206506497, 29233.41533169367, 32173.517397239528, 33254.33491330208, 35363.11592210215, 37373.62626373702, 37832.0, 6412.454941330039, 6576.80269591913, 6754.5609535380045, 6794.116764820542, 6888.138982627172, 9014.278857691237, 9957.763726788678, 10261.58953641846, 10418.479076046318, 10561.471926403803, 7238.846980066901, 7253.637318133967, 7980.441369104107, 8027.719029833927, 8444.451110677786, 8180.631871565913, 8308.584570771316, 8431.934176126888, 8496.830063398822, 8531.914680853111, 2575.5364034473223, 2588.1200391866855, 5014.34813474246, 7060.775855605468, 8384.83230335402, 6623.768168114093, 6841.452683785185, 6846.418054465426, 6902.206246281742, 6904.447644188554, 6765.2896445872475, 7776.183500732342, 8213.753587392388, 8274.462159959583, 8336.458130221516], "unit": "score", "name": "jquery.html", "value": 7620.561573981088}, {"lowerIsBetter": false, "replicates": [1388.1879100726076, 1393.5053056165061, 1504.7366710825602, 1677.0, 1699.0400423760566, 6298.527610429213, 6495.188101487314, 7275.29030677791, 7474.065741782278, 7496.362809161221, 6975.965120174392, 7060.7528736494105, 7203.639818009092, 7216.278372162794, 7227.819304517389, 2159.276642324823, 2209.2930262316067, 2209.9116035358566, 2209.94475138122, 2213.0, 2074.761402438724, 2081.198738485679, 2149.6775483677416, 2152.3650523095725, 2161.448830548208, 2144.4638840289927, 2149.656055031195, 2160.2115227941767, 2160.9783902160934, 2206.1396055538353, 2191.7589065202815, 2191.780821917803, 2202.8347873909443, 2204.669299605056, 2205.580939621475, 2160.3950893749775, 2200.3179014505554, 2202.7797220277844, 2206.117552978805, 2206.360155554903, 7551.169371369145, 7591.127020392671, 7604.315611594983, 7655.081390233152, 7658.157602663702, 4248.638865696419, 4344.1311737652595, 4369.257226271541, 4390.714603550759, 4404.625606823424, 2284.7601001894895, 2357.5049239659693, 2702.5135475614384, 2756.0491630387683, 2765.2948498132846, 815.1929589706208, 829.2122483640505, 835.1147783349669, 835.4569529805614, 849.8257857139272, 10124.89875101247, 10140.89859101407, 10147.036031576989, 10158.644447444378, 10182.338148020355, 4144.088300573869, 4154.8338066477, 4234.597713217239, 4238.788060596958, 4249.68127390447, 8928.598213080428, 8947.239484643878, 8959.328050396247, 8972.147645973622, 8984.685536006209, 4541.318802179633, 4572.7713614319155, 4578.427696537933, 4584.266517357207, 4599.264117741212, 4096.959030409717, 4109.568495308009, 4133.958660413357, 4161.126163505637, 4161.771102589326, 3485.634008429129, 3489.0, 3493.3013397320638, 3534.0634731796094, 3552.0764601203355, 1148.0757989818276, 1151.9193656443967, 1152.9884701153048, 1157.8147496400536, 1160.4739767206097, 916.0473107967772, 939.6053657463882, 1156.9652910412701, 1164.1036401970605, 1172.3434876469205, 6592.5055620828625, 6632.734690612321, 6643.335666433318, 6659.633720145342, 6680.131582894192, 1013.5287091502487, 1038.3354653022072, 1044.4621020174616, 1044.9791004179874, 1083.47992963378, 5020.2720605511995, 5038.2190760432195, 5039.77321020555, 5046.0, 5077.086124497552, 7841.0, 8299.419040667095, 8732.738017859474, 8773.07882672323, 8809.282189973022, 8551.059383467813, 8575.95712021436, 8592.957035214784, 8619.569021548898, 8627.43921645091, 6606.7026983785845, 6744.865102697919, 6804.421624161902, 6911.516193866381, 7007.5795452272005, 6749.751296010254, 6815.93184068153, 6821.488388370793, 6853.4859885507785, 6855.348741869514, 7579.924200757921, 7754.340881025176, 7800.063992320957, 7881.566513841564, 7890.053193616803, 7730.613469326624, 7903.091144518224, 7961.9203807963495, 7967.56178410193, 7968.681252749825, 6055.424734650202, 6138.079288106641, 6165.075238714228, 6170.10533472653, 6190.566660333733, 6929.965350173217, 7080.504364694422, 7084.043654106629, 7104.857902841811, 7108.040414543971, 6668.099806526251, 6682.966585167043, 6750.29121942189, 6801.18385793708, 6836.623985680636, 6726.7981960541265, 6740.224874139537, 6829.180498340231, 6850.126126305372, 6884.724611015503, 6886.965565172142, 6958.826029349307, 6960.129983752031, 6967.372936435745, 6975.546589471668, 6121.0, 6275.6862156892885, 6290.21372328459, 6305.8108256752375, 6312.2740884796995, 6409.7115629795835, 6425.775097871552, 6470.417662410406, 6471.482281417381, 6485.77299794505], "unit": "score", "name": "mootools.html", "value": 4225.8787272921045}, {"lowerIsBetter": false, "replicates": [312.3378437712051, 315.6065968747978, 318.97926634768754, 320.46642340503064, 328.06174341383644, 5569.220309156716, 5680.8295751127425, 5784.537237021033, 5787.797427090053, 5803.970980145104, 5612.915806262909, 5643.068893632546, 5678.290213723285, 5680.147977803332, 5683.0, 4191.476065491814, 4297.849575264866, 4301.161273551658, 4301.956980430203, 4332.718373305741, 4292.957070429303, 4311.3748506466545, 4328.653707703376, 4335.414719012941, 4343.804528796211, 4287.20686672965, 4302.655787537005, 4308.138372325532, 4309.870703878889, 4317.525072242051, 4303.26844436445, 4306.224879521685, 4307.82768689252, 4316.740995540277, 4319.913601727979, 3632.7093832493338, 3734.6265373462707, 3735.794531300777, 3738.925221495555, 3744.251149770057, 5287.0, 5447.618666693333, 5451.64564303319, 5451.918221226685, 5454.263674403945, 4922.286268491049, 4943.505649435064, 4948.307236986825, 4955.554000140005, 4965.726885021322, 5938.732757025944, 5941.019731744257, 5945.227120474311, 5959.940400595982, 5960.493358064569, 3938.3895496198134, 4062.7156099073077, 4064.512258528966, 4082.326416141333, 4084.1627466369323, 6202.875942481171, 6209.099680546341, 6280.089387038854, 6281.654509002003, 6290.24517057956, 4173.812178451977, 4180.581941805795, 4195.0, 4196.391523229115, 4198.244316023145, 4237.385579091015, 4251.681123915719, 4258.339957306623, 4269.996550810557, 4280.315149576053, 4737.076270127292, 4791.95208047922, 4852.757362131879, 4899.240617704261, 4916.139675556763, 5898.056310990221, 5939.643621382731, 5947.286325640865, 5985.610935289193, 5986.5210783137245, 1488.0327786938576, 1515.886308526865, 1521.9010764300285, 1522.6345677037432, 1524.1845612597428, 958.5303201431249, 1005.4319309590204, 1018.1905385218769, 1022.0188618925766, 1023.2376879225025, 5142.0744266031725, 5185.325907632059, 5205.713685747244, 5210.8957820844125, 5216.504432078947, 6124.908126378108, 6133.877322453526, 6150.292716337678, 6151.108089327023, 6184.257889053342, 5161.5870730341485, 5166.509181627739, 5201.843944681666, 5206.401263854706, 5209.71346575942, 3267.3138640885204, 3335.483000134983, 3352.1116904020455, 3381.1716129548417, 3405.182756138509, 5832.12518122285, 5843.035899076604, 5872.882542349214, 5876.7355469004, 5885.323187833368, 6455.289918109004, 6474.9676251619385, 6478.578892371981, 6489.643069631215, 6495.447886929664, 5710.914336284959, 5892.646441213541, 5899.056151015817, 5906.675132867734, 5921.970390148108, 6278.748850045947, 6286.18279623646, 6293.465055470337, 6302.086197501245, 6302.810915672537, 6106.8167954959645, 6114.266288045285, 6140.508759299335, 6140.662263575547, 6147.66187859672, 5779.2775903012125, 5888.381719919346, 5907.793227237026, 5919.171316015675, 5922.5261979040715, 4171.311733564049, 4213.9789301054525, 4215.557366476599, 4219.767912764827, 4221.451211342629, 6156.753729850756, 6229.906551401823, 6266.310705822265, 6279.874402512016, 6286.37136286386, 6005.459508644243, 6018.428249316308, 6030.6080104793045, 6034.63792172471, 6034.668093254913, 5969.552283578836, 5991.430814072656, 5995.27215117112, 6008.1588577598295, 6014.218151640259, 5660.547156227574, 5842.444967728059, 5863.530917526673, 5863.589548731547, 5872.324682661549, 6020.87958240824, 6056.878862422815, 6065.696715164136, 6067.969660151847, 6071.605345652519, 5907.143464197581, 5910.852228694317, 5911.320198177093, 5917.408259174048, 5928.288605367211], "unit": "score", "name": "prototype.html", "value": 4457.13732191699}, {"lowerIsBetter": false, "replicates": [676.8713944350574, 679.4530403025568, 759.0739298056372, 782.0966783365211, 795.8845967334732, 11278.718032049203, 11388.316700997946, 11405.14461415393, 11416.714582135452, 11474.311541307507, 12611.43248553815, 12724.745505089915, 12759.36203189839, 12808.807867881966, 12826.230426174436, 774.0711146624045, 781.316348195329, 794.6940427935228, 794.6940427935258, 795.8607243732324, 781.4178437064395, 782.460102529253, 783.9294463498284, 786.5752493653421, 788.0582703669118, 820.2207902492626, 823.5141266652673, 825.0099880143821, 825.3232349473434, 828.2214718164936, 802.4102284820681, 809.8339840332748, 810.0562844286429, 811.9878201826978, 815.5799763121997, 602.1599868183858, 604.2326245668021, 606.0394275074013, 607.5959486941179, 608.6287364707525, 12044.81932771009, 12073.27560346382, 12081.939590301992, 12090.516379344816, 12107.455164517618, 11729.178957472981, 12000.819987700192, 12007.264499225921, 12054.216475929124, 12075.0, 9160.404573702688, 9182.586783594754, 9226.400283981588, 9229.307801914816, 9233.169014788702, 3245.853936572836, 3307.1566750478714, 3314.5028245763087, 3314.5193946877807, 3400.2349471368993, 41011.0, 41271.0, 41322.93235707827, 41468.58531414707, 41691.1661766763, 8933.821323573622, 9688.598519314, 9815.852762208573, 9866.605335786488, 9870.654527091518, 16348.509544713677, 16364.0, 16470.75293870593, 16502.587435313973, 16504.75242871358, 6702.09521714572, 6828.556143850733, 6850.38346548813, 6878.140232470942, 7099.822504437327, 3642.85428582859, 3645.799481028569, 3651.2514934438377, 3682.705383569308, 3739.102615372291, 2684.463107378532, 2703.635009273762, 2711.444153948436, 2715.3890374665543, 2718.497078040569, 497.6740235145985, 504.02722745102307, 506.5010964200333, 507.2796628787131, 512.1191550533077, 495.8388523729802, 555.6721534294785, 563.8533981164927, 567.6168586204295, 595.8838026584774, 7523.8495230095095, 7533.660985255677, 7612.961935190399, 7831.569263690438, 7844.4901081429525, 479.4749749024812, 562.7945799783132, 565.926429564154, 567.6792612174108, 576.469647923911, 3364.5962484502015, 3445.594956892949, 3465.833853841349, 3545.2732189901008, 3589.10272431892, 45362.31956520655, 45624.0, 45869.5413045872, 45938.77030614892, 46396.0, 41472.792636036625, 42102.789486052374, 42366.36450453246, 42437.36343954843, 42497.0, 36152.63847361493, 36820.63179368225, 38039.61960380361, 38379.424308635396, 38442.615573844465, 6703.4302084321425, 6834.487413443912, 6870.7595234166565, 6962.338577835098, 7126.2873712628325, 28591.997120403576, 29000.854995724887, 29439.705602944552, 29447.85276073606, 30602.0, 35426.46860297046, 35987.64012359843, 36032.63967360293, 36079.098022549646, 36144.45783313305, 9740.707778766648, 9982.550785214828, 9992.350497217658, 10061.547230374797, 10094.343867648578, 10647.094996925349, 11102.888971110186, 11400.201985860911, 11413.029892459233, 11414.94292528532, 9151.0, 9166.0, 9189.77025574366, 9274.304427167854, 9325.906740932503, 10359.0, 10757.892421075689, 10763.51564179598, 10861.076808471053, 11036.11711063129, 9351.532423378667, 9611.279154063333, 9691.951540242535, 9847.572102045307, 10148.188144948239, 8290.170982901662, 8552.144785521647, 8673.869891951752, 8688.0, 8856.690015849414, 7796.337311328601, 8249.463784853966, 8386.538740369338, 8464.238218560358, 8721.127887211229], "unit": "score", "name": "yui.html", "value": 5607.822667543635}], "name": "dromaeo_css", "value": 6244.759708162746}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 115.0, 115.0, 115.0, 125.0, 116.0, 115.0, 113.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [162.0, 138.0, 155.0, 171.0, 141.0, 157.0, 166.0, 140.0, 174.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 154.6}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 164.0, 163.0, 164.0, 167.0, 171.0, 163.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 74.0, 158.0, 74.0, 75.0, 73.0, 74.0, 150.0, 73.0], "unit": "score", "name": "audio-fft", "value": 90.1}, {"lowerIsBetter": true, "replicates": [99.0, 100.0, 149.0, 96.0, 96.0, 97.0, 148.0, 98.0, 98.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 111.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 115.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.7}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 147.0, 148.0, 151.0, 148.0, 147.0, 149.0, 149.0, 158.0], "unit": "score", "name": "imaging-darkroom", "value": 149.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 70.0, 71.0, 71.0, 69.0, 77.0, 68.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 67.0, 68.0, 67.0, 67.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [80.0, 84.0, 85.0, 84.0, 83.0, 83.0, 84.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 126.0, 136.0, 122.0, 125.0, 123.0, 124.0, 129.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [140.0, 150.0, 151.0, 163.0, 147.0, 136.0, 148.0, 146.0, 147.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 70.0, 72.0, 72.0, 71.0, 70.0, 72.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1558.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "Richards", "value": 211.14126199999998}, {"lowerIsBetter": false, "replicates": [187.93459875963165], "unit": "score", "name": "DeltaBlue", "value": 351.8138780000001}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1082.2510822510822], "unit": "score", "name": "RayTrace", "value": 683.7498360000003}, {"lowerIsBetter": false, "replicates": [721.7015140591204], "unit": "score", "name": "Earley", "value": 923.4607202797202}, {"lowerIsBetter": false, "replicates": [12884.615384615385], "unit": "score", "name": "Boyer", "value": 51.72548656716421}, {"lowerIsBetter": false, "replicates": [43382.97872340425], "unit": "score", "name": "RegExp", "value": 20.998673369298682}, {"lowerIsBetter": false, "replicates": [591.3660555884093], "unit": "score", "name": "Splay", "value": 137.80128099999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20162.899943900404}]} 04:20:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20162.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1558.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6244.76"}}} 04:20:59 INFO - Return code: 0 04:20:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:20:59 INFO - # TBPL SUCCESS # 04:20:59 INFO - Running post-action listener: _resource_record_post_action 04:20:59 INFO - Running post-run listener: _resource_record_post_run 04:21:00 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 541794304; Read time: 0; Write time: 636184 04:21:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 168509440; Read time: 0; Write time: 245360 04:21:00 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 309911552; Read time: 0; Write time: 346588 04:21:00 INFO - Running post-run listener: _upload_blobber_files 04:21:00 INFO - Blob upload gear active. 04:21:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:00 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 04:21:00 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'] 04:21:00 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 04:21:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:21:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:21:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:01 INFO - (blobuploader) - INFO - Done attempting. 04:21:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:21:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:21:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:04 INFO - (blobuploader) - INFO - Done attempting. 04:21:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:04 INFO - Return code: 0 04:21:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ad49b0a88a7143d157e622ac2c1df28e235a00b8367dad77c4cfa1d381b8515017ef11ce197e82de5a5889dce8bf73d5df9cf855840413c2841ad1db4418271", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa1d253a67e5e3b5b3f912509fe05cee849a3a8644354e6263881c504b2390f33e11a2b0a64ae1527e209ed3b50b23d6686da350b7efebe20966806fa04f343b"} 04:21:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:04 INFO - Contents: 04:21:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ad49b0a88a7143d157e622ac2c1df28e235a00b8367dad77c4cfa1d381b8515017ef11ce197e82de5a5889dce8bf73d5df9cf855840413c2841ad1db4418271", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa1d253a67e5e3b5b3f912509fe05cee849a3a8644354e6263881c504b2390f33e11a2b0a64ae1527e209ed3b50b23d6686da350b7efebe20966806fa04f343b"} 04:21:04 INFO - Copying logs to upload dir... 04:21:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1293.116325 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-12 04:21:03.845182) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 04:21:03.850963) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ad49b0a88a7143d157e622ac2c1df28e235a00b8367dad77c4cfa1d381b8515017ef11ce197e82de5a5889dce8bf73d5df9cf855840413c2841ad1db4418271", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa1d253a67e5e3b5b3f912509fe05cee849a3a8644354e6263881c504b2390f33e11a2b0a64ae1527e209ed3b50b23d6686da350b7efebe20966806fa04f343b"} build_url:https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/SXLz0jJWToS5HhI1A-I16A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ad49b0a88a7143d157e622ac2c1df28e235a00b8367dad77c4cfa1d381b8515017ef11ce197e82de5a5889dce8bf73d5df9cf855840413c2841ad1db4418271", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa1d253a67e5e3b5b3f912509fe05cee849a3a8644354e6263881c504b2390f33e11a2b0a64ae1527e209ed3b50b23d6686da350b7efebe20966806fa04f343b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 04:21:03.875501) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:21:03.875832) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452593630.634089-666602245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:21:03.960377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 04:21:03.960697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 04:21:03.960998) ========= ========= Total master_lag: 0.26 =========