builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1452740950.87 results: success (0) buildid: 20160113173732 builduid: 3a5d1ed2990047b3a1c0d787c5317eab revision: 4e2224c009dfedfcd95035e2fc67779567c2cdea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:10.869955) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:10.870407) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:10.870732) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006356 basedir: '/builds/slave/test' ========= master_lag: 0.11 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:10.983062) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:10.983380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:10.996910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:10.997215) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:11.048114) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:11.048798) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:11.049357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:11.049674) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 19:09:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2016-01-13 19:09:11 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106095 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:11.168654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:11.169000) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022280 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:11.218827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 19:09:11.219170) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e2224c009dfedfcd95035e2fc67779567c2cdea --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 4e2224c009dfedfcd95035e2fc67779567c2cdea --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=652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 19:09:11,423 truncating revision to first 12 chars 2016-01-13 19:09:11,423 Setting DEBUG logging. 2016-01-13 19:09:11,423 attempt 1/10 2016-01-13 19:09:11,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e2224c009df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 19:09:12,278 unpacking tar archive at: mozilla-central-4e2224c009df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.173746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 19:09:12.406292) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:12.406665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:12.416802) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:12.417517) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 19:09:12.418278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-13 19:09:12.418826) ========= /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=652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:09:12 INFO - MultiFileLogger online at 20160113 19:09:12 in /builds/slave/test 19:09:12 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 19:09:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:09:12 INFO - {'append_to_log': False, 19:09:12 INFO - 'base_work_dir': '/builds/slave/test', 19:09:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:09:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:09:12 INFO - 'branch': 'Firefox-Non-PGO', 19:09:12 INFO - 'buildbot_json_path': 'buildprops.json', 19:09:12 INFO - 'config_files': ('talos/linux_config.py',), 19:09:12 INFO - 'default_actions': ('clobber', 19:09:12 INFO - 'read-buildbot-config', 19:09:12 INFO - 'download-and-extract', 19:09:12 INFO - 'populate-webroot', 19:09:12 INFO - 'create-virtualenv', 19:09:12 INFO - 'install', 19:09:12 INFO - 'run-tests'), 19:09:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:09:12 INFO - 'download_minidump_stackwalk': True, 19:09:12 INFO - 'download_symbols': 'ondemand', 19:09:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:09:12 INFO - 'tooltool.py': '/tools/tooltool.py', 19:09:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:09:12 INFO - '/tools/misc-python/virtualenv.py')}, 19:09:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:09:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:09:12 INFO - 'installer_path': 'installer.exe', 19:09:12 INFO - 'log_level': 'info', 19:09:12 INFO - 'log_name': 'talos', 19:09:12 INFO - 'log_to_console': True, 19:09:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:09:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:09:12 INFO - 'opt_config_files': (), 19:09:12 INFO - 'pip_index': False, 19:09:12 INFO - 'sps_profile': False, 19:09:12 INFO - 'sps_profile_interval': 0, 19:09:12 INFO - 'suite': 'dromaeojs-e10s', 19:09:12 INFO - 'system_bits': '32', 19:09:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:09:12 INFO - 'title': 'talos-linux64-ix-046', 19:09:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:09:12 INFO - 'use_talos_json': True, 19:09:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:09:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:09:12 INFO - 'work_dir': 'build'} 19:09:12 INFO - ##### 19:09:12 INFO - ##### Running clobber step. 19:09:12 INFO - ##### 19:09:12 INFO - Running pre-action listener: _resource_record_pre_action 19:09:12 INFO - Running main action method: clobber 19:09:12 INFO - rmtree: /builds/slave/test/build 19:09:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:09:13 INFO - Running post-action listener: _resource_record_post_action 19:09:13 INFO - ##### 19:09:13 INFO - ##### Running read-buildbot-config step. 19:09:13 INFO - ##### 19:09:13 INFO - Running pre-action listener: _resource_record_pre_action 19:09:13 INFO - Running main action method: read_buildbot_config 19:09:13 INFO - Using buildbot properties: 19:09:13 INFO - { 19:09:13 INFO - "project": "", 19:09:13 INFO - "product": "firefox", 19:09:13 INFO - "script_repo_revision": "production", 19:09:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:09:13 INFO - "repository": "", 19:09:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:09:13 INFO - "buildid": "20160113173732", 19:09:13 INFO - "pgo_build": "False", 19:09:13 INFO - "basedir": "/builds/slave/test", 19:09:13 INFO - "buildnumber": 155, 19:09:13 INFO - "slavename": "talos-linux64-ix-046", 19:09:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:09:13 INFO - "platform": "ubuntu64_hw", 19:09:13 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:09:13 INFO - "branch": "mozilla-central", 19:09:13 INFO - "repo_path": "mozilla-central", 19:09:13 INFO - "revision": "4e2224c009dfedfcd95035e2fc67779567c2cdea", 19:09:13 INFO - "stage_platform": "linux64", 19:09:13 INFO - "builduid": "3a5d1ed2990047b3a1c0d787c5317eab", 19:09:13 INFO - "slavebuilddir": "test" 19:09:13 INFO - } 19:09:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:09:13 INFO - Running post-action listener: _resource_record_post_action 19:09:13 INFO - ##### 19:09:13 INFO - ##### Running download-and-extract step. 19:09:13 INFO - ##### 19:09:13 INFO - Running pre-action listener: _resource_record_pre_action 19:09:13 INFO - Running main action method: download_and_extract 19:09:13 INFO - mkdir: /builds/slave/test/build/tests 19:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:13 INFO - https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:09:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/test_packages.json 19:09:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/test_packages.json 19:09:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:09:13 INFO - Downloaded 1448 bytes. 19:09:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:09:13 INFO - Using the following test package requirements: 19:09:13 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:09:13 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:09:13 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:09:13 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:13 INFO - u'jsshell-linux-x86_64.zip'], 19:09:13 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:09:13 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:09:13 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:09:13 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:09:13 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:09:13 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:09:13 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:09:13 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:13 INFO - https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:09:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:09:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:09:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/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 19:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/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 19:09:16 INFO - Downloaded 22762442 bytes. 19:09:16 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 19:09:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:09:16 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 19:09:17 INFO - Return code: 0 19:09:17 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 19:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:17 INFO - https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/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 19:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/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 19:09:19 INFO - Downloaded 22762442 bytes. 19:09:19 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 19:09:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:09:19 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 19:09:21 INFO - Return code: 0 19:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:21 INFO - https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/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 19:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/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 19:09:22 INFO - Downloaded 11132279 bytes. 19:09:22 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 19:09:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:09:22 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 19:09:23 INFO - Return code: 0 19:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:23 INFO - https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/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 19:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VhAY7HQMQ5mvoXaAxxy53g/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 19:09:26 INFO - Downloaded 53893312 bytes. 19:09:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:09:26 INFO - mkdir: /builds/slave/test/properties 19:09:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:09:26 INFO - Writing to file /builds/slave/test/properties/build_url 19:09:26 INFO - Contents: 19:09:26 INFO - build_url:https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:09:26 INFO - Running post-action listener: _resource_record_post_action 19:09:26 INFO - Running post-action listener: set_extra_try_arguments 19:09:26 INFO - ##### 19:09:26 INFO - ##### Running populate-webroot step. 19:09:26 INFO - ##### 19:09:26 INFO - Running pre-action listener: _resource_record_pre_action 19:09:26 INFO - Running main action method: populate_webroot 19:09:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:09:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:09:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:09:26 INFO - '--tppagecycles', 19:09:26 INFO - '7'], 19:09:26 INFO - 'tests': ['tsvgm']}}, 19:09:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:09:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:09:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:09:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:09:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:09:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:09:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:26 INFO - 'talos_options': ['--e10s'], 19:09:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:26 INFO - 'tests': ['damp', 'tps']}, 19:09:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:26 INFO - 'talos_options': ['--e10s'], 19:09:26 INFO - 'tests': ['damp', 'tps']}, 19:09:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:09:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:09:26 INFO - 'other': {'tests': ['a11yr', 19:09:26 INFO - 'ts_paint', 19:09:26 INFO - 'tpaint', 19:09:26 INFO - 'sessionrestore', 19:09:26 INFO - 'sessionrestore_no_auto_restore']}, 19:09:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:09:26 INFO - 'tests': ['a11yr', 19:09:26 INFO - 'ts_paint', 19:09:26 INFO - 'tpaint', 19:09:26 INFO - 'sessionrestore', 19:09:26 INFO - 'sessionrestore_no_auto_restore']}, 19:09:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:09:26 INFO - 'tests': ['a11yr', 19:09:26 INFO - 'ts_paint', 19:09:26 INFO - 'tpaint', 19:09:26 INFO - 'sessionrestore', 19:09:26 INFO - 'sessionrestore_no_auto_restore']}, 19:09:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:09:26 INFO - 'tests': ['a11yr', 19:09:26 INFO - 'ts_paint', 19:09:26 INFO - 'tpaint', 19:09:26 INFO - 'sessionrestore', 19:09:26 INFO - 'sessionrestore_no_auto_restore']}, 19:09:26 INFO - 'other_l64': {'tests': ['a11yr', 19:09:26 INFO - 'ts_paint', 19:09:26 INFO - 'tpaint', 19:09:26 INFO - 'sessionrestore', 19:09:26 INFO - 'sessionrestore_no_auto_restore']}, 19:09:26 INFO - 'other_nol64': {'tests': ['a11yr', 19:09:26 INFO - 'ts_paint', 19:09:26 INFO - 'tpaint', 19:09:26 INFO - 'sessionrestore', 19:09:26 INFO - 'sessionrestore_no_auto_restore']}, 19:09:26 INFO - 'svgr': {'tests': ['tsvgx', 19:09:26 INFO - 'tsvgr_opacity', 19:09:26 INFO - 'tart', 19:09:26 INFO - 'tscrollx', 19:09:26 INFO - 'cart']}, 19:09:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:09:26 INFO - 'tests': ['tsvgx', 19:09:26 INFO - 'tsvgr_opacity', 19:09:26 INFO - 'tart', 19:09:26 INFO - 'tscrollx', 19:09:26 INFO - 'cart']}, 19:09:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:26 INFO - 'tests': ['tp5o']}, 19:09:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:26 INFO - 'talos_options': ['--e10s'], 19:09:26 INFO - 'tests': ['tp5o']}, 19:09:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:26 INFO - 'talos_options': ['--xperf_path', 19:09:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:26 INFO - 'tests': ['tp5n']}, 19:09:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:26 INFO - 'talos_options': ['--e10s', 19:09:26 INFO - '--xperf_path', 19:09:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:26 INFO - 'tests': ['tp5n']}}, 19:09:26 INFO - 'talos.zip': {'path': '', 19:09:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:09:26 INFO - Running post-action listener: _resource_record_post_action 19:09:26 INFO - ##### 19:09:26 INFO - ##### Running create-virtualenv step. 19:09:26 INFO - ##### 19:09:26 INFO - Running pre-action listener: _resource_record_pre_action 19:09:26 INFO - Running main action method: create_virtualenv 19:09:26 INFO - Creating virtualenv /builds/slave/test/build/venv 19:09:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:09:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:09:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:09:26 INFO - Using real prefix '/usr' 19:09:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:09:26 INFO - Installing distribute.............................................................................................................................................................................................done. 19:09:28 INFO - Installing pip.................done. 19:09:28 INFO - Return code: 0 19:09:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:28 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 0x7f75358bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', '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 19:09:28 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 19:09:28 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 19:09:28 INFO - Using env: {'DISPLAY': ':0', 19:09:28 INFO - 'HOME': '/home/cltbld', 19:09:28 INFO - 'LANG': 'en_US.UTF-8', 19:09:28 INFO - 'LANGUAGE': 'en_US:en', 19:09:28 INFO - 'LOGNAME': 'cltbld', 19:09:28 INFO - 'MAIL': '/var/mail/cltbld', 19:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:28 INFO - 'MOZ_NO_REMOTE': '1', 19:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:28 INFO - 'NO_EM_RESTART': '1', 19:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:28 INFO - 'PWD': '/builds/slave/test', 19:09:28 INFO - 'SHELL': '/bin/bash', 19:09:28 INFO - 'SHLVL': '1', 19:09:28 INFO - 'TERM': 'linux', 19:09:28 INFO - 'TMOUT': '86400', 19:09:28 INFO - 'USER': 'cltbld', 19:09:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:28 INFO - '_': '/tools/buildbot/bin/python'} 19:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:28 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 19:09:28 INFO - Cleaning up... 19:09:29 INFO - Return code: 0 19:09:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75358bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', '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 19:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:09:29 INFO - Using env: {'DISPLAY': ':0', 19:09:29 INFO - 'HOME': '/home/cltbld', 19:09:29 INFO - 'LANG': 'en_US.UTF-8', 19:09:29 INFO - 'LANGUAGE': 'en_US:en', 19:09:29 INFO - 'LOGNAME': 'cltbld', 19:09:29 INFO - 'MAIL': '/var/mail/cltbld', 19:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:29 INFO - 'MOZ_NO_REMOTE': '1', 19:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:29 INFO - 'NO_EM_RESTART': '1', 19:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:29 INFO - 'PWD': '/builds/slave/test', 19:09:29 INFO - 'SHELL': '/bin/bash', 19:09:29 INFO - 'SHLVL': '1', 19:09:29 INFO - 'TERM': 'linux', 19:09:29 INFO - 'TMOUT': '86400', 19:09:29 INFO - 'USER': 'cltbld', 19:09:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:29 INFO - '_': '/tools/buildbot/bin/python'} 19:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:29 INFO - Downloading/unpacking psutil>=0.7.1 19:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:09:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:09:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:31 INFO - Installing collected packages: psutil 19:09:31 INFO - Running setup.py install for psutil 19:09:31 INFO - building 'psutil._psutil_linux' extension 19:09:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:09:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:09:31 INFO - building 'psutil._psutil_posix' extension 19:09:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:09:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:09:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:31 INFO - Successfully installed psutil 19:09:31 INFO - Cleaning up... 19:09:31 INFO - Return code: 0 19:09:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:31 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 0x7f75358bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', '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 19:09:31 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 19:09:31 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 19:09:31 INFO - Using env: {'DISPLAY': ':0', 19:09:31 INFO - 'HOME': '/home/cltbld', 19:09:31 INFO - 'LANG': 'en_US.UTF-8', 19:09:31 INFO - 'LANGUAGE': 'en_US:en', 19:09:31 INFO - 'LOGNAME': 'cltbld', 19:09:31 INFO - 'MAIL': '/var/mail/cltbld', 19:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:31 INFO - 'MOZ_NO_REMOTE': '1', 19:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:31 INFO - 'NO_EM_RESTART': '1', 19:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:31 INFO - 'PWD': '/builds/slave/test', 19:09:31 INFO - 'SHELL': '/bin/bash', 19:09:31 INFO - 'SHLVL': '1', 19:09:31 INFO - 'TERM': 'linux', 19:09:31 INFO - 'TMOUT': '86400', 19:09:31 INFO - 'USER': 'cltbld', 19:09:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:31 INFO - '_': '/tools/buildbot/bin/python'} 19:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:09:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:09:33 INFO - Installing collected packages: mozsystemmonitor 19:09:33 INFO - Running setup.py install for mozsystemmonitor 19:09:33 INFO - Successfully installed mozsystemmonitor 19:09:33 INFO - Cleaning up... 19:09:33 INFO - Return code: 0 19:09:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:09:33 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')]} 19:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:33 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')]} 19:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:33 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 0x7f75358bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', '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 19:09:33 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 19:09:33 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 19:09:33 INFO - Using env: {'DISPLAY': ':0', 19:09:33 INFO - 'HOME': '/home/cltbld', 19:09:33 INFO - 'LANG': 'en_US.UTF-8', 19:09:33 INFO - 'LANGUAGE': 'en_US:en', 19:09:33 INFO - 'LOGNAME': 'cltbld', 19:09:33 INFO - 'MAIL': '/var/mail/cltbld', 19:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:33 INFO - 'MOZ_NO_REMOTE': '1', 19:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:33 INFO - 'NO_EM_RESTART': '1', 19:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:33 INFO - 'PWD': '/builds/slave/test', 19:09:33 INFO - 'SHELL': '/bin/bash', 19:09:33 INFO - 'SHLVL': '1', 19:09:33 INFO - 'TERM': 'linux', 19:09:33 INFO - 'TMOUT': '86400', 19:09:33 INFO - 'USER': 'cltbld', 19:09:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:33 INFO - '_': '/tools/buildbot/bin/python'} 19:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:33 INFO - Downloading/unpacking blobuploader==1.2.4 19:09:33 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 19:09:33 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 19:09:33 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 19:09:33 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 19:09:33 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 19:09:33 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 19:09:35 INFO - Downloading blobuploader-1.2.4.tar.gz 19:09:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:09:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:09:35 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 19:09:35 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 19:09:35 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 19:09:35 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 19:09:35 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 19:09:35 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 19:09:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:09:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:36 INFO - Downloading docopt-0.6.1.tar.gz 19:09:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:09:36 INFO - Installing collected packages: blobuploader, requests, docopt 19:09:36 INFO - Running setup.py install for blobuploader 19:09:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:09:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:09:36 INFO - Running setup.py install for requests 19:09:36 INFO - Running setup.py install for docopt 19:09:36 INFO - Successfully installed blobuploader requests docopt 19:09:36 INFO - Cleaning up... 19:09:36 INFO - Return code: 0 19:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:36 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')]} 19:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:36 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')]} 19:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:36 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 0x7f75358bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', '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 19:09:36 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 19:09:36 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 19:09:36 INFO - Using env: {'DISPLAY': ':0', 19:09:36 INFO - 'HOME': '/home/cltbld', 19:09:36 INFO - 'LANG': 'en_US.UTF-8', 19:09:36 INFO - 'LANGUAGE': 'en_US:en', 19:09:36 INFO - 'LOGNAME': 'cltbld', 19:09:36 INFO - 'MAIL': '/var/mail/cltbld', 19:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:36 INFO - 'MOZ_NO_REMOTE': '1', 19:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:36 INFO - 'NO_EM_RESTART': '1', 19:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:36 INFO - 'PWD': '/builds/slave/test', 19:09:36 INFO - 'SHELL': '/bin/bash', 19:09:36 INFO - 'SHLVL': '1', 19:09:36 INFO - 'TERM': 'linux', 19:09:36 INFO - 'TMOUT': '86400', 19:09:36 INFO - 'USER': 'cltbld', 19:09:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:36 INFO - '_': '/tools/buildbot/bin/python'} 19:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:37 INFO - Running setup.py (path:/tmp/pip-v9xpVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:37 INFO - Running setup.py (path:/tmp/pip-HDY8uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:37 INFO - Running setup.py (path:/tmp/pip-RNlD9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:37 INFO - Running setup.py (path:/tmp/pip-tPqwW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:37 INFO - Running setup.py (path:/tmp/pip-p6hhGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:37 INFO - Running setup.py (path:/tmp/pip-YlcXhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:37 INFO - Running setup.py (path:/tmp/pip-EaBpb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:37 INFO - Running setup.py (path:/tmp/pip-DEtsFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:37 INFO - Running setup.py (path:/tmp/pip-e8FNWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:37 INFO - Running setup.py (path:/tmp/pip-z50JCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:37 INFO - Running setup.py (path:/tmp/pip-c0_bNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:37 INFO - Running setup.py (path:/tmp/pip-CWRize-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:38 INFO - Running setup.py (path:/tmp/pip-TiYaJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:38 INFO - Running setup.py (path:/tmp/pip-V2X77i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:38 INFO - Running setup.py (path:/tmp/pip-W9Dd8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:38 INFO - Running setup.py (path:/tmp/pip-vj4Goh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:38 INFO - Running setup.py (path:/tmp/pip-tvSbiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:09:38 INFO - Running setup.py install for manifestparser 19:09:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:09:38 INFO - Running setup.py install for mozcrash 19:09:38 INFO - Running setup.py install for mozdebug 19:09:38 INFO - Running setup.py install for mozdevice 19:09:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:09:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:09:38 INFO - Running setup.py install for mozfile 19:09:38 INFO - Running setup.py install for mozhttpd 19:09:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:09:38 INFO - Running setup.py install for mozinfo 19:09:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Running setup.py install for mozInstall 19:09:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Running setup.py install for mozleak 19:09:39 INFO - Running setup.py install for mozlog 19:09:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Running setup.py install for moznetwork 19:09:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Running setup.py install for mozprocess 19:09:39 INFO - Running setup.py install for mozprofile 19:09:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Running setup.py install for mozrunner 19:09:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:09:39 INFO - Running setup.py install for mozscreenshot 19:09:39 INFO - Running setup.py install for moztest 19:09:40 INFO - Running setup.py install for mozversion 19:09:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:09:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:09:40 INFO - Cleaning up... 19:09:40 INFO - Return code: 0 19:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75358bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', '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 19:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:09:40 INFO - Using env: {'DISPLAY': ':0', 19:09:40 INFO - 'HOME': '/home/cltbld', 19:09:40 INFO - 'LANG': 'en_US.UTF-8', 19:09:40 INFO - 'LANGUAGE': 'en_US:en', 19:09:40 INFO - 'LOGNAME': 'cltbld', 19:09:40 INFO - 'MAIL': '/var/mail/cltbld', 19:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:40 INFO - 'MOZ_NO_REMOTE': '1', 19:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:40 INFO - 'NO_EM_RESTART': '1', 19:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:40 INFO - 'PWD': '/builds/slave/test', 19:09:40 INFO - 'SHELL': '/bin/bash', 19:09:40 INFO - 'SHLVL': '1', 19:09:40 INFO - 'TERM': 'linux', 19:09:40 INFO - 'TMOUT': '86400', 19:09:40 INFO - 'USER': 'cltbld', 19:09:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:40 INFO - '_': '/tools/buildbot/bin/python'} 19:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:40 INFO - Running setup.py (path:/tmp/pip-ukPkKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:40 INFO - Running setup.py (path:/tmp/pip-EB__eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:40 INFO - Running setup.py (path:/tmp/pip-GmeAFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:40 INFO - Running setup.py (path:/tmp/pip-AwR5nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:40 INFO - Running setup.py (path:/tmp/pip-b_36EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:40 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)) 19:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:40 INFO - Running setup.py (path:/tmp/pip-Ffq5jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:40 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)) 19:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:40 INFO - Running setup.py (path:/tmp/pip-QaRgGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:40 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)) 19:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:40 INFO - Running setup.py (path:/tmp/pip-auT3je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:40 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)) 19:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:40 INFO - Running setup.py (path:/tmp/pip-HjhBaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:41 INFO - Running setup.py (path:/tmp/pip-2wK2Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:41 INFO - Running setup.py (path:/tmp/pip-Ov5EjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:41 INFO - Running setup.py (path:/tmp/pip-tcZqt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:41 INFO - Running setup.py (path:/tmp/pip-gPjOI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:41 INFO - Running setup.py (path:/tmp/pip-M2MCiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:41 INFO - Running setup.py (path:/tmp/pip-gnXSem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:41 INFO - Running setup.py (path:/tmp/pip-7Pufo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:41 INFO - Running setup.py (path:/tmp/pip-ygHm2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:41 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)) 19:09:41 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)) 19:09:41 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)) 19:09:41 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)) 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:09:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:09:41 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 19:09:41 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 19:09:41 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 19:09:41 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 19:09:41 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 19:09:41 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 19:09:43 INFO - Downloading blessings-1.5.1.tar.gz 19:09:43 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:09:43 INFO - Installing collected packages: blessings 19:09:43 INFO - Running setup.py install for blessings 19:09:43 INFO - Successfully installed blessings 19:09:43 INFO - Cleaning up... 19:09:43 INFO - Return code: 0 19:09:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:43 INFO - Reading from file tmpfile_stdout 19:09:43 INFO - Current package versions: 19:09:43 INFO - argparse == 1.2.1 19:09:43 INFO - blessings == 1.5.1 19:09:43 INFO - blobuploader == 1.2.4 19:09:43 INFO - docopt == 0.6.1 19:09:43 INFO - manifestparser == 1.1 19:09:43 INFO - mozInstall == 1.12 19:09:43 INFO - mozcrash == 0.16 19:09:43 INFO - mozdebug == 0.1 19:09:43 INFO - mozdevice == 0.48 19:09:43 INFO - mozfile == 1.2 19:09:43 INFO - mozhttpd == 0.7 19:09:43 INFO - mozinfo == 0.9 19:09:43 INFO - mozleak == 0.1 19:09:43 INFO - mozlog == 3.1 19:09:43 INFO - moznetwork == 0.27 19:09:43 INFO - mozprocess == 0.22 19:09:43 INFO - mozprofile == 0.28 19:09:43 INFO - mozrunner == 6.11 19:09:43 INFO - mozscreenshot == 0.1 19:09:43 INFO - mozsystemmonitor == 0.0 19:09:43 INFO - moztest == 0.7 19:09:43 INFO - mozversion == 1.4 19:09:43 INFO - psutil == 3.1.1 19:09:43 INFO - requests == 1.2.3 19:09:43 INFO - wsgiref == 0.1.2 19:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:43 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')]} 19:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:43 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')]} 19:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:43 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 0x7f75358bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', '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 19:09:43 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 19:09:43 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 19:09:43 INFO - Using env: {'DISPLAY': ':0', 19:09:43 INFO - 'HOME': '/home/cltbld', 19:09:43 INFO - 'LANG': 'en_US.UTF-8', 19:09:43 INFO - 'LANGUAGE': 'en_US:en', 19:09:43 INFO - 'LOGNAME': 'cltbld', 19:09:43 INFO - 'MAIL': '/var/mail/cltbld', 19:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:43 INFO - 'MOZ_NO_REMOTE': '1', 19:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:43 INFO - 'NO_EM_RESTART': '1', 19:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:43 INFO - 'PWD': '/builds/slave/test', 19:09:43 INFO - 'SHELL': '/bin/bash', 19:09:43 INFO - 'SHLVL': '1', 19:09:43 INFO - 'TERM': 'linux', 19:09:43 INFO - 'TMOUT': '86400', 19:09:43 INFO - 'USER': 'cltbld', 19:09:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:43 INFO - '_': '/tools/buildbot/bin/python'} 19:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:43 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)) 19:09:43 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)) 19:09:43 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)) 19:09:43 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)) 19:09:43 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)) 19:09:43 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)) 19:09:43 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)) 19:09:43 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)) 19:09:43 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)) 19:09:43 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)) 19:09:43 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)) 19:09:43 INFO - Cleaning up... 19:09:43 INFO - Return code: 0 19:09:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:09:43 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')]} 19:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:43 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')]} 19:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:43 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 0x7f75358bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', '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 19:09:43 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 19:09:43 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 19:09:43 INFO - Using env: {'DISPLAY': ':0', 19:09:43 INFO - 'HOME': '/home/cltbld', 19:09:43 INFO - 'LANG': 'en_US.UTF-8', 19:09:43 INFO - 'LANGUAGE': 'en_US:en', 19:09:43 INFO - 'LOGNAME': 'cltbld', 19:09:43 INFO - 'MAIL': '/var/mail/cltbld', 19:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:43 INFO - 'MOZ_NO_REMOTE': '1', 19:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:43 INFO - 'NO_EM_RESTART': '1', 19:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:43 INFO - 'PWD': '/builds/slave/test', 19:09:43 INFO - 'SHELL': '/bin/bash', 19:09:43 INFO - 'SHLVL': '1', 19:09:43 INFO - 'TERM': 'linux', 19:09:43 INFO - 'TMOUT': '86400', 19:09:43 INFO - 'USER': 'cltbld', 19:09:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:43 INFO - '_': '/tools/buildbot/bin/python'} 19:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:44 INFO - Downloading/unpacking jsonschema 19:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:09:45 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 19:09:45 INFO - Downloading/unpacking functools32 (from jsonschema) 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:46 INFO - Downloading functools32-3.2.3-2.tar.gz 19:09:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:09:46 INFO - warning: no files found matching '*.txt' 19:09:46 INFO - no previously-included directories found matching 'build' 19:09:46 INFO - no previously-included directories found matching 'dist' 19:09:46 INFO - no previously-included directories found matching '.git*' 19:09:46 INFO - Installing collected packages: jsonschema, functools32 19:09:46 INFO - Running setup.py install for functools32 19:09:46 INFO - warning: no files found matching '*.txt' 19:09:46 INFO - no previously-included directories found matching 'build' 19:09:46 INFO - no previously-included directories found matching 'dist' 19:09:46 INFO - no previously-included directories found matching '.git*' 19:09:46 INFO - Successfully installed jsonschema functools32 19:09:46 INFO - Cleaning up... 19:09:46 INFO - Return code: 0 19:09:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75358bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', '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 19:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:09:46 INFO - Using env: {'DISPLAY': ':0', 19:09:46 INFO - 'HOME': '/home/cltbld', 19:09:46 INFO - 'LANG': 'en_US.UTF-8', 19:09:46 INFO - 'LANGUAGE': 'en_US:en', 19:09:46 INFO - 'LOGNAME': 'cltbld', 19:09:46 INFO - 'MAIL': '/var/mail/cltbld', 19:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:46 INFO - 'MOZ_NO_REMOTE': '1', 19:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:46 INFO - 'NO_EM_RESTART': '1', 19:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:46 INFO - 'PWD': '/builds/slave/test', 19:09:46 INFO - 'SHELL': '/bin/bash', 19:09:46 INFO - 'SHLVL': '1', 19:09:46 INFO - 'TERM': 'linux', 19:09:46 INFO - 'TMOUT': '86400', 19:09:46 INFO - 'USER': 'cltbld', 19:09:46 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:46 INFO - '_': '/tools/buildbot/bin/python'} 19:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:46 INFO - Downloading/unpacking flake8 19:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:09:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:09:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:09:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:09:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:48 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 19:09:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:09:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:48 INFO - no previously-included directories found matching 'docs/_build' 19:09:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:09:49 INFO - Running setup.py install for pep8 19:09:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:49 INFO - no previously-included directories found matching 'docs/_build' 19:09:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:09:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:09:49 INFO - Cleaning up... 19:09:49 INFO - Return code: 0 19:09:49 INFO - Running post-action listener: _resource_record_post_action 19:09:49 INFO - Running post-action listener: _start_resource_monitoring 19:09:49 INFO - Starting resource monitoring. 19:09:49 INFO - ##### 19:09:49 INFO - ##### Running install step. 19:09:49 INFO - ##### 19:09:49 INFO - Running pre-action listener: _resource_record_pre_action 19:09:49 INFO - Running main action method: install 19:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:49 INFO - Reading from file tmpfile_stdout 19:09:49 INFO - Detecting whether we're running mozinstall >=1.0... 19:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:09:49 INFO - Reading from file tmpfile_stdout 19:09:49 INFO - Output received: 19:09:49 INFO - Usage: mozinstall [options] installer 19:09:49 INFO - Options: 19:09:49 INFO - -h, --help show this help message and exit 19:09:49 INFO - -d DEST, --destination=DEST 19:09:49 INFO - Directory to install application into. [default: 19:09:49 INFO - "/builds/slave/test"] 19:09:49 INFO - --app=APP Application being installed. [default: firefox] 19:09:49 INFO - mkdir: /builds/slave/test/build/application 19:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:10:05 INFO - Reading from file tmpfile_stdout 19:10:05 INFO - Output received: 19:10:05 INFO - /builds/slave/test/build/application/firefox/firefox 19:10:05 INFO - Running post-action listener: _resource_record_post_action 19:10:05 INFO - ##### 19:10:05 INFO - ##### Running run-tests step. 19:10:05 INFO - ##### 19:10:05 INFO - Running pre-action listener: _resource_record_pre_action 19:10:05 INFO - Running main action method: run_tests 19:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:05 INFO - Python 2.7.3 19:10:05 INFO - Return code: 0 19:10:05 INFO - grabbing minidump binary from tooltool 19:10: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')]} 19:10:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593d0>, '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 0xec4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:10:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:10:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:05 INFO - Return code: 0 19:10:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:10:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:10:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:10:06 INFO - Return code: 0 19:10:06 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/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:10:06 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/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 19:10:06 INFO - Using env: {'DISPLAY': ':0', 19:10:06 INFO - 'HOME': '/home/cltbld', 19:10:06 INFO - 'LANG': 'en_US.UTF-8', 19:10:06 INFO - 'LANGUAGE': 'en_US:en', 19:10:06 INFO - 'LOGNAME': 'cltbld', 19:10:06 INFO - 'MAIL': '/var/mail/cltbld', 19:10:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:06 INFO - 'MOZ_NO_REMOTE': '1', 19:10:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:06 INFO - 'NO_EM_RESTART': '1', 19:10:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:06 INFO - 'PWD': '/builds/slave/test', 19:10:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:06 INFO - 'SHELL': '/bin/bash', 19:10:06 INFO - 'SHLVL': '1', 19:10:06 INFO - 'TERM': 'linux', 19:10:06 INFO - 'TMOUT': '86400', 19:10:06 INFO - 'USER': 'cltbld', 19:10:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761', 19:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:06 INFO - '_': '/tools/buildbot/bin/python'} 19:10:06 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/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:10:06 INFO - mozversion application_buildid: 20160113173732 19:10:06 INFO - mozversion application_changeset: 4e2224c009dfedfcd95035e2fc67779567c2cdea 19:10:06 INFO - mozversion application_display_name: Nightly 19:10:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:06 INFO - mozversion application_name: Firefox 19:10:06 INFO - mozversion application_remotingname: firefox 19:10:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:10:06 INFO - mozversion application_vendor: Mozilla 19:10:06 INFO - mozversion application_version: 46.0a1 19:10:06 INFO - mozversion platform_buildid: 20160113173732 19:10:06 INFO - mozversion platform_changeset: 4e2224c009dfedfcd95035e2fc67779567c2cdea 19:10:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:10:06 INFO - mozversion platform_version: 46.0a1 19:10:06 INFO - using testdate: 1452741006 19:10:06 INFO - actual date: 1452741006 19:10:06 INFO - starting webserver on 'localhost:49311' 19:10:06 INFO - SUITE-START | Running 3 tests 19:10:06 INFO - TEST-START | dromaeo_css 19:10:06 INFO - operating with platform_type : linux_ 19:10:06 INFO - Initialising browser for dromaeo_css test... 19:10:06 INFO - TEST-INFO | started process 23921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw8qVdg/profile http://localhost:49311/getInfo.html) 19:10:10 INFO - PROCESS | 23921 | 19:10:10 INFO - PROCESS | 23921 | (process:24007): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:10:11 INFO - PROCESS | 23921 | __metrics Screen width/height:1600/1200 19:10:11 INFO - PROCESS | 23921 | colorDepth:24 19:10:11 INFO - PROCESS | 23921 | Browser inner width/height: 1024/697 19:10:11 INFO - PROCESS | 23921 | __metrics 19:10:11 INFO - PROCESS | 23921 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:10:12 INFO - TEST-INFO | 23921: exit 0 19:10:12 INFO - Browser initialized. 19:10:12 INFO - Running cycle 1/1 for dromaeo_css test... 19:10:12 INFO - TEST-INFO | started process 24056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw8qVdg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:13 INFO - PROCESS | 24056 | 19:10:13 INFO - PROCESS | 24056 | (process:24114): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:10:24 INFO - PROCESS | 24056 | RSS: Main: 150421504 19:10:24 INFO - PROCESS | 24056 | 19:11:14 INFO - PROCESS | 24056 | 1452741074081 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] 19:13:23 INFO - PROCESS | 24056 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49311/tests/dromaeo/cssquery-ext.html) 19:13:25 INFO - PROCESS | 24056 | RSS: Main: 156950528 19:13:25 INFO - PROCESS | 24056 | 19:16:27 INFO - PROCESS | 24056 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-ext.html (next: http://localhost:49311/tests/dromaeo/cssquery-jquery.html) 19:16:27 INFO - PROCESS | 24056 | RSS: Main: 153198592 19:16:27 INFO - PROCESS | 24056 | 19:19:29 INFO - PROCESS | 24056 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49311/tests/dromaeo/cssquery-mootools.html) 19:19:30 INFO - PROCESS | 24056 | RSS: Main: 150962176 19:19:30 INFO - PROCESS | 24056 | 19:22:32 INFO - PROCESS | 24056 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49311/tests/dromaeo/cssquery-prototype.html) 19:22:32 INFO - PROCESS | 24056 | RSS: Main: 149344256 19:22:32 INFO - PROCESS | 24056 | 19:25:35 INFO - PROCESS | 24056 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49311/tests/dromaeo/cssquery-yui.html) 19:25:35 INFO - PROCESS | 24056 | RSS: Main: 151502848 19:25:35 INFO - PROCESS | 24056 | 19:28:38 INFO - PROCESS | 24056 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-yui.html (next: http://localhost:49311/tests/dromaeo/cssquery-dojo.html) 19:28:38 INFO - PROCESS | 24056 | RSS: Main: 153608192 19:28:38 INFO - PROCESS | 24056 | 19:28:38 INFO - PROCESS | 24056 | __start_tp_report 19:28:38 INFO - PROCESS | 24056 | _x_x_mozilla_page_load 19:28:38 INFO - PROCESS | 24056 | _x_x_mozilla_page_load_details 19:28:38 INFO - PROCESS | 24056 | |i|pagename|runs| 19:28:38 INFO - PROCESS | 24056 | |0;dojo.html;2537.08664880643;2592.0798116668593;2614.6078088286754;2617.9083732069394;2635.617835413864;4291.184674911765;4466.151431228064;4481.5070342262325;4487.237169681154;4498.100379924012;4315.590018948203;4409.228385032615;4434.113177364524;4435.512093669694;4435.911281774371;188.59637791613912;4060.8578699745517;4064.552899181088;4095.795210239491;4151.73013754105;3828.349180639284;4011.5587285398583;4034.939475907849;4046.858359957402;4081.857135000276;4033.0925541753163;4052.1085361220485;4052.6757859371473;4087.2438598859308;4100.261952848486;3922.921541569153;3988.481497405348;4100.0569868930015;4107.938380924288;4150.709450338478;4006.9198616027807;4042.8787136385954;4069.552349241581;4088.795560221977;4100.138970816102;4288.056627541936;4311.784410779448;4332.1985432695055;4350.347447882843;4397.7361358318285;4494.280915053576;4589;4708.364370809931;4712.151812673717;4742.193827049376;4655.697379670344;4681.906361872778;4688.038952014829;4707.270373092142;4727.432708075053;4341.2836881914445;4359.760213188273;4361.345798130305;4367.10474352757;4400.405945197389;4669.4630117536235;4737.24204127338;4765.404324459442;4773.570378665937;4863.124637565272;4571.862844114682;4580.541945805459;4583.839565615254;4588.587027167504;4604.861854144381;4660.39414876064;4679.134360143385;4679.789409476582;4697.976510117427;4718.882027949328;4432.49026361966;4552.453705555355;4552.931706024412;4564.2012647786505;4565.680402371802;4574.611158051536;4599.5400459953735;4614.861554153381;4625.444946606362;4663.743494107789;3965.7025723070883;3994.6005399459823;3999.0202400412086;4004.6395824375945;4036.394540818842;3408.829558522064;3415.9829200853837;3486.4247399178853;3507.0706262840367;3548.503209550665;4083.571225021389;4100.466939297872;4101.835926562904;4108;4139.751614903115;4684.672072954861;4692.812287508462;4694.976525117352;4695.694779839299;4738.905221895543;3945.9802700986884;4019.93970090443;4024;4097.651699605507;4152.045029643199;4215.515215750228;4215.747055176699;4226.070264541796;4233.534311225762;4268.210381079511;4486.977565112154;4499.842505512292;4544.477385100689;4547.772611369484;4598.517155698671;4457.04173602677;4522.3442600823355;4532.32015197723;4737.763111844463;4777.21176005969;4541.84103556374;4549.044700612776;4550.180967425895;4564.041551274269;4585.6102231310715;4654.418197725285;4659.720416775004;4683.391159149289;4726.220173671443;4730.905381892412;4470.821167153277;4596.793144308447;4602.562756538124;4605.562471565196;4743.383360163295;4468.240399132091;4505.3692483053055;4509.706869053501;4523.932141017822;4537.069900670421;4534.501204867528;4538.614217791393;4543.909121817611;4570.657200709894;4596.126735920165;4349.543297953669;4417.580329868657;4464.50890402062;4477.1493416250805;4482.238019536621;4465.397171381952;4480.39514665516;4595.770211489479;4650.441946966385;4681.929771053369;4443.955670417514;4449.377087207728;4449.644028477649;4459.197344478025;4488.5960263576435 19:28:38 INFO - PROCESS | 24056 | |1;ext.html;492.15595254139123;508.56263613292583;529.4308618235398;539.649228001799;546.721172202177;31794.20514487139;32508.67491325086;32554.99999999997;32598.511022334653;32639.1840203995;35712.46431303533;36307;36354.63645363545;36397.63602363975;36426.271474570494;7611.54330740156;7764.767056988299;7767.184445633184;7799.649015794274;7801.907732917396;7567.735129270477;7703.3452156566755;7727.768166955;7864.882026769603;7865.095514015876;7844;7864.056313242419;7929.405294602899;7931.365490760754;7936.603169841514;7764.689412423496;7833.686652533892;7836.490628109212;7861.56761378124;7861.646225919847;7691.269329413697;7735.110462296851;7738.690452381898;7796.883046754303;7840.843183136305;35445;35680.46479302813;35687.4646880297;35841.283174336626;36183.63816361829;3066.0955018269665;3084.475639141351;3103.4103520331064;3417.4532074868152;3681.531134765528;26600.60099098515;26961;27024.59463108055;27051.45897082067;27489.862550687318;3059.3422414180836;3118.5322201669705;3166.0818362674795;3184;3198.4722520784044;210083;211558;212352;213228;213784;44961.550384495735;46594.30108548375;52400;52739;52748.73625631847;54813;55716.72141639266;55835.44164558302;56119;56260.43739562634;13491.730165396637;13754;13759.312034398241;13773.724525509635;13782.586522404345;10441.530131144116;10619.044286014296;10629.734256643645;10631.255812093079;10642.36145831237;17111.57221069483;17338.826611733723;17347.913260433616;18265.63468730618;18273.360432385067;7036.577805331594;7041.0846589944;7241.348278654841;7255.419566434673;7272.63636818157;891.2023738753909;922.4234853216606;930.1070971867083;973.8977407372124;981.8134554434635;25101.24696259115;25172.118975835758;25415.36461588475;25425;25713.614295785577;949.6486300069018;957.9281553883486;985.2265971212564;996.6910257820099;1089.3790539392628;13131.934340328236;13452.663683407993;13661.726765464635;13692.877603971401;14493.492727754478;253120;257711;258114;259179;259628;41800.37299440511;42860.35709464361;43055.35416968748;43075.56924430715;43327.35008974868;1227.018385291763;1232.3406977267118;1233.2538814017391;1239.1202246405153;1248.3009514671812;25933.610995835454;26062.087826925967;26232;26400.339991500365;26404;38715.41926871043;39112.21775564416;39166.608333916294;39284.41073383844;39291.60708392879;233082;235826;236005;236251;236599;25079.24762257135;25735.871320643277;26487.470250595266;27092.187234383;27130.593041104796;31568.36863262676;31889;36942.26115477621;37052.62947370492;38052;27203;27469.31326716848;27492.58761118625;27871.442571148058;28226;27446.313842154104;29519.55720664235;30141.849290753406;30762.384752305275;31170.844145779127;30503.542446863758;31015.844920775253;31289.217769555944;31352.37295254128;31413.685863141076;25938.481230375663;28291.43417131687;28364.716352836207;28377;28390.85804570964;22627.773722262566;22666.43333916665;22730;22800.65799012983;22916 19:28:38 INFO - PROCESS | 24056 | |2;jquery.html;321.15055677732386;322.4035534261616;331.05648900633196;331.9907481256979;334.96161898115844;13875.79186312205;14437.422503099877;14493.420263189473;14732.33704483298;15639.374425022985;9449.858252126207;9689.903100968988;11158.888411115906;14822.481213157515;14857;4438.489573699034;4496.595306422421;4642.442906851183;4695.765211739416;5103.642745007851;4947.109520286347;5040.1935690289565;5063.468335824722;5078;5081.618878584102;3367.3770352484867;3520.964790352102;4879.487653796354;5047.31861198739;6130.44825965663;6364.109024736541;6498.5126115541525;6533;6637.734490620345;6666.733330666768;6317.968410157966;6320.115183874262;6332.398422149889;6334.398232167937;6347.174867267272;18125.909370453195;19735.40793776189;20015.79984200154;20215.79784202154;20656.07047682858;1838.3014454507202;1856.786469556005;1946.8247857692734;1971.7338159348449;2060.24800947653;12862.163959342706;13078.149920255248;13130.934345328307;13169.078164528486;13244.735105297936;1823.963520729578;1840.2679286784162;1887.4526387347653;1888.6411581799414;1893.2048539613395;50520.242196367086;51681;53636;53637.731811340695;53713.19430208589;14246.580820603187;14517.637059073397;14538.127712337293;14547.78178327326;14587.343569539396;21715.131394744032;21855.562888742137;21884.12463501474;21951.231706890183;21988.560228795654;8181.959090204511;8183.386246031571;8212.548309843016;8378.24595786382;8392.706255281037;7002.159740831133;7097.290270972965;7251.202367739545;7325.706971721072;7331.046963894766;7113.857722845514;7201.96399018012;7276.527025743309;7345.228750981177;7412.221716719775;1707.812140664526;2973.910782676523;2990.5065664165604;3015;3067.2331917020747;368.54852805313277;380.423658157891;388.615270881825;742.38011260598;845.6279237135641;8681.435706679045;9138.68014619485;9449.811003779885;9908.35595686278;9950.452725100044;392.1040422634324;392.4760444806159;392.7427534964603;393.2155350076616;868.70898249086;7916.366690664733;8020.759377218693;8475.957620211982;8859.64561417536;9126.543672816333;443815;446663;475398;480636;481992;38356.04109897219;38383.61616383856;52190.73904630452;62037;62990.68504657447;1057.5452555401098;1069.652362982034;1078.218291738499;1083.1172594335592;1087.5758454202867;13886.93056534711;13964.531205670051;14025.3688584016;14098.859011409755;14156.150630962175;26793;27383.589246161722;27600.585991209748;29356.266093347836;29869.70130298669;32195.195120122185;32202.35595288128;32544.51183232301;36957.26085478329;37081.62918370782;6065.696715164136;6456;6478.676066196577;6516.609003459807;6831.419329357061;7980.401469889665;9563.952180239332;9602.85595716051;9623.470709111067;10352;7680.731174408869;7724.575148366894;7780.299773020229;7829.491083079582;7880.802979925547;8312.836202931716;8318.251357377865;8366.790830229293;8546.145385461652;8647.178518041028;2583.134649892307;2601.3366591519043;5190.714510701797;6591.670416479061;8180.181981801772;6340.809775706736;6461;6464.480847001045;6607.603543787388;6620.66896655175;7522.8871566925445;8362.45644033136;8370.916290837014;8405.201505856934;8613.956930215309 19:28:38 INFO - PROCESS | 24056 | |3;mootools.html;1391.5547024952016;1397.8392484864237;1503.751880939645;1694.2375930831113;1697.0666133626503;6055.5155587553;6225.5953363031485;6682.599044057354;6931.618760968151;6959.0953176087105;6815.522913396064;7069.964650176755;7130.572165670063;7140.785776426703;7155.677994490247;1938.5832046110083;1966.2921348314596;1967.7048442733633;1968.252064215596;1970.8916009619466;1994.3219305436148;2017.3241963942096;2029.0666293504933;2032.9695054574192;2055.0341339570455;1976.9209231630718;1987.7912819153998;1998.2906068345746;2006.769221539527;2010.698395240711;2036.6741321388506;2040.143139881246;2041.8264447521979;2042.2137477071285;2047.119738512439;2010.447127040061;2045.3761602711168;2084.6768750843644;2090.0281369163413;2091.393495886191;7285.599292038935;7291.34377905991;7348.522346047544;7352.375048120916;7383.2247614000835;4009.6190861868076;4062.8781136565653;4074.8370065197355;4087.89780255493;4126.504819421689;2432.221689059502;2461.0155937624913;2497.500499900009;2662.826916250457;2663.893444262227;799.3365506629542;800.0639252075086;813.6419975210947;814.9837003259961;816.6855760532178;9790.804183916282;9848.310618256724;9861.60553577856;9921.702348929544;10048.995100489965;3617.439296908983;3631.9636803631624;3647.252313275772;3685.760425572329;3701.148735790783;8616.138386161334;8628.52543110135;8633.870491942625;8685.348598855111;8692.348073894484;3935.8622448214173;3978.0651546886456;3979.263836190314;3985.5416627087675;3987.222491614107;3196.696313850227;3262.624798148196;3599.2441587266967;3634.0733113056003;3650.671439570451;3233.7736358455154;3266.6896644818703;3270.329582435595;3274.2141885947676;3286.6877646623534;999.8000399919899;1009.7475631092227;1012.6759436980243;1020.5560581147224;1042.838360054193;811.5090370325986;823.7446391618618;920.9861852072224;1055.0820785916303;1059.5814653212092;6528.445082167974;6536.477081833442;6569.67151642416;6588;6744.291849355845;1013.4172850610928;1018.1091544898214;1021.7547788530848;1027.5632856036154;1044.5456226541478;5170.870728231825;5232.581393488512;5234.18870075139;5249.580033597303;5251.343582052244;8569.742907712778;8674.132586741402;9142.542872856331;9145.725628231165;9192.31057670664;8938.642454301755;8958.731238062868;8971.19259266656;8983.101689830964;8984.640614375483;6468.482521398371;6571.244306904767;6619;6663.233728121328;6674.699638516278;6242.500599952084;6256.655883926428;6308.495320374451;6314.84212894663;6315.273743519554;7388.445866559922;7474.738384156529;7484.850302993801;7495.213002634645;7512.661930213044;7384.150822655463;7653.387728981556;7669.233076692286;7690.461667683208;7708.229177082471;5276.261323414648;5417.187421886749;6114.541409394402;6257.499400047895;6283.59156654816;6511.869762604816;6638.668066596748;6652.068710380454;6655.434288085567;6707.832304192434;6328.588641738273;6428.19647544057;6513.772017979348;6553.115329430466;6608;6321.683915804283;6376.585521941244;6381;6427.100205971261;6492.0261960706275;6389.456896163692;6448.161738973903;6466.935330646634;6477.481801455967;6480.902786458301;5645.689487078086;5665.065264231521;5707.914381284201;5724.513416359656;5764.279465066867;5915.526757859275;6022.819315420545;6028.276606807036;6045.365236650265;6077.149199112217 19:28:38 INFO - PROCESS | 24056 | |4;prototype.html;299.4669488310807;310.8849725601528;312.30512110554014;318.83898631191244;321.44550650128514;5460.836174914754;5542.778288868445;5556.611037227391;5592.049351610226;5598.552115830734;5430.782768689248;5454.10007348787;5479.726013699319;5509.393966663663;5527.060399732045;4056.574059723731;4186.79066046698;4268.295731204355;4276.486821581415;4287.528371879091;4171.8539851105215;4180.310248808943;4184.121334519755;4187.51843537994;4202.474690663667;4153.958460415387;4155.563665815092;4157.792110394468;4160.105577300879;4160.417541544171;4196.664266858644;4200.537940826506;4201.579842015789;4204.894877628053;4212.262854000568;3645.0887278180453;3671.118931456458;3671.7429779915415;3672.173760903802;3679.098620837885;5150.896982060338;5190.169572868361;5216.374035115772;5224.320838290998;5255.737213139328;4843.782029808632;4875.07373599015;4881.5606595406225;4885.633577481668;4899.387576552931;5757.453041961007;5763.423657634245;5766.740496677659;5768.048272035109;5799.18811366409;3955.3275943089743;4041.009952561641;4053.574374690674;4069.4302797608357;4069.837206511736;5974.522038236931;6035.758569657209;6049;6054.757809687651;6060.36366181549;4203.243416185116;4204.558521355275;4207.558206388285;4207.705460617727;4224.408582798411;4267.765272909957;4276.444062271885;4279.165562715303;4283.164782867311;4286.764227967492;4767.880802979953;4865.513448655177;4867.9269810952865;4870.196417591129;4877.975610121926;5735.913961290584;5753.683547404933;5757;5771.249737534094;5775.971120144372;1502.6168327076525;1526.2368815592204;1526.7938828258043;1529.5946574157856;1531.4104069932932;1035.30634474902;1037.2946396450336;1046.7592453735683;1052.2318707343682;1059.369675043348;5011.6241281904;5022.723750193774;5024.57291130258;5033.446320904697;5034.395872495324;5985.401459854067;5991.400859913973;5998;6002.189704389852;6007.849803754853;4998.825041123616;4998.8502644391265;5017.397912250481;5035.62232832539;5050.646454748133;3141.874325026973;3209.069369882708;3225.935481290408;3227.9193020174685;3243.7080662739995;5455.945440545624;5643.7742490299925;5651.463111004448;5652.406497317723;5653.745581448762;5977.880442391128;6017.187679663277;6226.128342032119;6243.969744992026;6244;5665.348484924287;5719.828405147769;5725.484706376446;5737.770489180386;5748.281464816898;6018.909716354171;6025.939740602538;6032.90950635732;6039.667818270037;6039.818805435844;5732.713364331683;5913.46778789911;5914.378990205966;5923.911141332797;5937.406259374028;5673.432656734293;5677.3754886963225;5707.543396528351;5709.25779648643;5724.914126288192;4060.4112403700706;4091.774952377648;4097.160082183205;4105.096878686684;4109.137081212979;5842.474177324061;6002.459778619946;6002.759889604367;6010.669413182317;6034.125051867367;5807.361190268983;5815.79644712433;5823.301203855564;5832.883342333044;5835.241418615553;5785.305763308262;5805.390434004537;5818.0981947798155;5825.825225243249;5832.0085585451425;5512.373136042082;5683.8863222736145;5698.6580805151825;5701.857453563694;5702.34423041339;5795.217645617788;5812.3025236971835;5844.970775146097;5849.210356601804;5856.765729370948;5677.1768093627015;5682.971585142048;5687.914681279867;5692.060809966475;5695.971520142372 19:28:38 INFO - PROCESS | 24056 | |5;yui.html;693.5110746923416;731.4331393170293;779.4465929190276;784.5332027443669;794.4240425691374;11903;12049.337286449241;12058.155929084967;12077.094217933669;12093.879061209396;10740.87220841812;10988.560457581707;11622.07023438125;11668.35824029678;11721.179517433782;745.6085555083583;755.2560727683227;760.0195747485736;760.4486747108358;760.7147319755092;758.2758465665304;759.654357267442;760.3271105071996;760.7185341423653;763.2405756272517;783.4085265624445;785.9135495095535;786.1195461083565;788.538704857659;793.1275596843454;776.5651235308218;781.3358645151604;782.3897360059163;783.0212234706617;786.7757689058648;586.1237450012259;588.8027510783893;589.4635881347996;589.5813972079828;591.1074277840492;10874.18443616724;10999.780004399867;11022.669319920415;11054.723631909186;11061;9732.610695572168;9767.072128147815;9785.810972211151;10032.849507257397;10058.446785426799;8472.173164652679;8780.473171609723;8864.024957254696;8975.416597921114;9028.909710902873;3040.5743195952587;3064.1879901826032;3097.9535306970415;3183.3474137801695;3242.659520750311;37573.62426375729;42687;44167;44360;44551;9581.712548623553;9607.855882161633;9649.372790768577;9652.131308182297;9750.122488975885;15909.363625455084;15962.680746385007;15986;16008.839911600968;16025.198740063184;6431.163948686734;6505.121808555879;6510.641914694643;6703.798886033427;6721.899171512431;3690.3605152353084;3691.2617476504806;3712.461693054492;3772.962435330251;3774.0753515388355;2548.1718441506587;2560.5135024345313;2570.370259286487;2624.265205742395;2624.9868750656124;466.45890766710454;472.9739864307496;473.4200604259754;477.80410031887453;479.2954357095065;495.81902605548714;539.6896784349015;552.304096837987;560.5039540007123;610.0752127039199;7506.13679426862;7586.506877052974;7703.845923081507;7845.803854903673;7962.880556791652;542.9131338985743;604.9546284028715;604.9758009679564;621.8631900981777;640.2317219336815;3416.6583341666133;3482.6169121396624;3582.7133829293593;3603.837827297778;3610.711143108545;46312.53687463082;46485.5351446488;46851.765741171075;46884.7655761719;47062;38311.42532862009;38422.80788596095;38437.99999999944;38442.80778596089;38637.2272554553;32530.349393012006;38517.42223866644;38610;40127.79936100301;40230.19539609191;7010.719571217094;7189.496735228484;7970.561619111005;8017;8636.697715580176;27528.724712752617;28154.577681335206;29522.99999999914;29820.70179298266;29897.402051959274;36905.815470923546;37446;37510.24979500449;37580.436293456165;38331.42502862515;7808.063032436144;8193.016837979481;8258.628361723617;8568.914310856811;8570.185832345916;9517.095875891779;9589.136977672042;9630.422174669542;9730.854037189307;9976.501174941079;8390.496570205807;8704.26013788835;8721.127887211229;8730.34522410809;8791.648334066565;8765.956170219108;8873.600687969187;8963.551822408723;9027.187553120251;9301.441913485212;8314.127016663406;8399.076101628938;8483.10927352619;8539.316854651737;8546.78633034179;7627;7730.304272615492;7793.688252469838;7892.526448413114;8059.677612895419;7266.164391094881;7919.16848730898;7962.243586859239;8061.717839875576;8088.676452941816 19:28:38 INFO - PROCESS | 24056 | __end_tp_report 19:28:38 INFO - PROCESS | 24056 | __start_cc_report 19:28:38 INFO - PROCESS | 24056 | _x_x_mozilla_cycle_collect,329 19:28:38 INFO - PROCESS | 24056 | __end_cc_report 19:28:38 INFO - PROCESS | 24056 | __startTimestamp1452742118553__endTimestamp 19:28:38 INFO - PROCESS | 24056 | 19:28:38 INFO - PROCESS | 24056 | ------- Summary: start ------- 19:28:38 INFO - PROCESS | 24056 | Number of tests: 6 19:28:38 INFO - PROCESS | 24056 | 19:28:38 INFO - PROCESS | 24056 | [#0] dojo.html Cycles:165 Average:4311.01 Median:4468.24 stddev:532.51 (11.9%) stddev-sans-first:515.63 19:28:38 INFO - PROCESS | 24056 | Values: 2537.1 2592.1 2614.6 2617.9 2635.6 4291.2 4466.2 4481.5 4487.2 4498.1 4315.6 4409.2 4434.1 4435.5 4435.9 188.6 4060.9 4064.6 4095.8 4151.7 3828.3 4011.6 4034.9 4046.9 4081.9 4033.1 4052.1 4052.7 4087.2 4100.3 3922.9 3988.5 4100.1 4107.9 4150.7 4006.9 4042.9 4069.6 4088.8 4100.1 4288.1 4311.8 4332.2 4350.3 4397.7 4494.3 4589.0 4708.4 4712.2 4742.2 4655.7 4681.9 4688.0 4707.3 4727.4 4341.3 4359.8 4361.3 4367.1 4400.4 4669.5 4737.2 4765.4 4773.6 4863.1 4571.9 4580.5 4583.8 4588.6 4604.9 4660.4 4679.1 4679.8 4698.0 4718.9 4432.5 4552.5 4552.9 4564.2 4565.7 4574.6 4599.5 4614.9 4625.4 4663.7 3965.7 3994.6 3999.0 4004.6 4036.4 3408.8 3416.0 3486.4 3507.1 3548.5 4083.6 4100.5 4101.8 4108.0 4139.8 4684.7 4692.8 4695.0 4695.7 4738.9 3946.0 4019.9 4024.0 4097.7 4152.0 4215.5 4215.7 4226.1 4233.5 4268.2 4487.0 4499.8 4544.5 4547.8 4598.5 4457.0 4522.3 4532.3 4737.8 4777.2 4541.8 4549.0 4550.2 4564.0 4585.6 4654.4 4659.7 4683.4 4726.2 4730.9 4470.8 4596.8 4602.6 4605.6 4743.4 4468.2 4505.4 4509.7 4523.9 4537.1 4534.5 4538.6 4543.9 4570.7 4596.1 4349.5 4417.6 4464.5 4477.1 4482.2 4465.4 4480.4 4595.8 4650.4 4681.9 4444.0 4449.4 4449.6 4459.2 4488.6 19:28:38 INFO - PROCESS | 24056 | 19:28:38 INFO - PROCESS | 24056 | [#1] ext.html Cycles:180 Average:38567.58 Median:31491.03 stddev:61411.46 (195.0%) stddev-sans-first:61517.19 19:28:38 INFO - PROCESS | 24056 | Values: 492.2 508.6 529.4 539.6 546.7 31794.2 32508.7 32555.0 32598.5 32639.2 35712.5 36307.0 36354.6 36397.6 36426.3 7611.5 7764.8 7767.2 7799.6 7801.9 7567.7 7703.3 7727.8 7864.9 7865.1 7844.0 7864.1 7929.4 7931.4 7936.6 7764.7 7833.7 7836.5 7861.6 7861.6 7691.3 7735.1 7738.7 7796.9 7840.8 35445.0 35680.5 35687.5 35841.3 36183.6 3066.1 3084.5 3103.4 3417.5 3681.5 26600.6 26961.0 27024.6 27051.5 27489.9 3059.3 3118.5 3166.1 3184.0 3198.5 210083.0 211558.0 212352.0 213228.0 213784.0 44961.6 46594.3 52400.0 52739.0 52748.7 54813.0 55716.7 55835.4 56119.0 56260.4 13491.7 13754.0 13759.3 13773.7 13782.6 10441.5 10619.0 10629.7 10631.3 10642.4 17111.6 17338.8 17347.9 18265.6 18273.4 7036.6 7041.1 7241.3 7255.4 7272.6 891.2 922.4 930.1 973.9 981.8 25101.2 25172.1 25415.4 25425.0 25713.6 949.6 957.9 985.2 996.7 1089.4 13131.9 13452.7 13661.7 13692.9 14493.5 253120.0 257711.0 258114.0 259179.0 259628.0 41800.4 42860.4 43055.4 43075.6 43327.4 1227.0 1232.3 1233.3 1239.1 1248.3 25933.6 26062.1 26232.0 26400.3 26404.0 38715.4 39112.2 39166.6 39284.4 39291.6 233082.0 235826.0 236005.0 236251.0 236599.0 25079.2 25735.9 26487.5 27092.2 27130.6 31568.4 31889.0 36942.3 37052.6 38052.0 27203.0 27469.3 27492.6 27871.4 28226.0 27446.3 29519.6 30141.8 30762.4 31170.8 30503.5 31015.8 31289.2 31352.4 31413.7 25938.5 28291.4 28364.7 28377.0 28390.9 22627.8 22666.4 22730.0 22800.7 22916.0 19:28:38 INFO - PROCESS | 24056 | 19:28:38 INFO - PROCESS | 24056 | [#2] jquery.html Cycles:180 Average:24169.60 Median:243435.74 stddev:75910.11 (31.2%) stddev-sans-first:76101.94 19:28:38 INFO - PROCESS | 24056 | Values: 321.2 322.4 331.1 332.0 335.0 13875.8 14437.4 14493.4 14732.3 15639.4 9449.9 9689.9 11158.9 14822.5 14857.0 4438.5 4496.6 4642.4 4695.8 5103.6 4947.1 5040.2 5063.5 5078.0 5081.6 3367.4 3521.0 4879.5 5047.3 6130.4 6364.1 6498.5 6533.0 6637.7 6666.7 6318.0 6320.1 6332.4 6334.4 6347.2 18125.9 19735.4 20015.8 20215.8 20656.1 1838.3 1856.8 1946.8 1971.7 2060.2 12862.2 13078.1 13130.9 13169.1 13244.7 1824.0 1840.3 1887.5 1888.6 1893.2 50520.2 51681.0 53636.0 53637.7 53713.2 14246.6 14517.6 14538.1 14547.8 14587.3 21715.1 21855.6 21884.1 21951.2 21988.6 8182.0 8183.4 8212.5 8378.2 8392.7 7002.2 7097.3 7251.2 7325.7 7331.0 7113.9 7202.0 7276.5 7345.2 7412.2 1707.8 2973.9 2990.5 3015.0 3067.2 368.5 380.4 388.6 742.4 845.6 8681.4 9138.7 9449.8 9908.4 9950.5 392.1 392.5 392.7 393.2 868.7 7916.4 8020.8 8476.0 8859.6 9126.5 443815.0 446663.0 475398.0 480636.0 481992.0 38356.0 38383.6 52190.7 62037.0 62990.7 1057.5 1069.7 1078.2 1083.1 1087.6 13886.9 13964.5 14025.4 14098.9 14156.2 26793.0 27383.6 27600.6 29356.3 29869.7 32195.2 32202.4 32544.5 36957.3 37081.6 6065.7 6456.0 6478.7 6516.6 6831.4 7980.4 9564.0 9602.9 9623.5 10352.0 7680.7 7724.6 7780.3 7829.5 7880.8 8312.8 8318.3 8366.8 8546.1 8647.2 2583.1 2601.3 5190.7 6591.7 8180.2 6340.8 6461.0 6464.5 6607.6 6620.7 7522.9 8362.5 8370.9 8405.2 8614.0 19:28:38 INFO - PROCESS | 24056 | 19:28:38 INFO - PROCESS | 24056 | [#3] mootools.html Cycles:180 Average:4921.60 Median:6170.07 stddev:2639.52 (42.8%) stddev-sans-first:2633.59 19:28:38 INFO - PROCESS | 24056 | Values: 1391.6 1397.8 1503.8 1694.2 1697.1 6055.5 6225.6 6682.6 6931.6 6959.1 6815.5 7070.0 7130.6 7140.8 7155.7 1938.6 1966.3 1967.7 1968.3 1970.9 1994.3 2017.3 2029.1 2033.0 2055.0 1976.9 1987.8 1998.3 2006.8 2010.7 2036.7 2040.1 2041.8 2042.2 2047.1 2010.4 2045.4 2084.7 2090.0 2091.4 7285.6 7291.3 7348.5 7352.4 7383.2 4009.6 4062.9 4074.8 4087.9 4126.5 2432.2 2461.0 2497.5 2662.8 2663.9 799.3 800.1 813.6 815.0 816.7 9790.8 9848.3 9861.6 9921.7 10049.0 3617.4 3632.0 3647.3 3685.8 3701.1 8616.1 8628.5 8633.9 8685.3 8692.3 3935.9 3978.1 3979.3 3985.5 3987.2 3196.7 3262.6 3599.2 3634.1 3650.7 3233.8 3266.7 3270.3 3274.2 3286.7 999.8 1009.7 1012.7 1020.6 1042.8 811.5 823.7 921.0 1055.1 1059.6 6528.4 6536.5 6569.7 6588.0 6744.3 1013.4 1018.1 1021.8 1027.6 1044.5 5170.9 5232.6 5234.2 5249.6 5251.3 8569.7 8674.1 9142.5 9145.7 9192.3 8938.6 8958.7 8971.2 8983.1 8984.6 6468.5 6571.2 6619.0 6663.2 6674.7 6242.5 6256.7 6308.5 6314.8 6315.3 7388.4 7474.7 7484.9 7495.2 7512.7 7384.2 7653.4 7669.2 7690.5 7708.2 5276.3 5417.2 6114.5 6257.5 6283.6 6511.9 6638.7 6652.1 6655.4 6707.8 6328.6 6428.2 6513.8 6553.1 6608.0 6321.7 6376.6 6381.0 6427.1 6492.0 6389.5 6448.2 6466.9 6477.5 6480.9 5645.7 5665.1 5707.9 5724.5 5764.3 5915.5 6022.8 6028.3 6045.4 6077.1 19:28:38 INFO - PROCESS | 24056 | 19:28:38 INFO - PROCESS | 24056 | [#4] prototype.html Cycles:180 Average:4794.22 Median:5442.44 stddev:1408.27 (25.9%) stddev-sans-first:1371.21 19:28:38 INFO - PROCESS | 24056 | Values: 299.5 310.9 312.3 318.8 321.4 5460.8 5542.8 5556.6 5592.0 5598.6 5430.8 5454.1 5479.7 5509.4 5527.1 4056.6 4186.8 4268.3 4276.5 4287.5 4171.9 4180.3 4184.1 4187.5 4202.5 4154.0 4155.6 4157.8 4160.1 4160.4 4196.7 4200.5 4201.6 4204.9 4212.3 3645.1 3671.1 3671.7 3672.2 3679.1 5150.9 5190.2 5216.4 5224.3 5255.7 4843.8 4875.1 4881.6 4885.6 4899.4 5757.5 5763.4 5766.7 5768.0 5799.2 3955.3 4041.0 4053.6 4069.4 4069.8 5974.5 6035.8 6049.0 6054.8 6060.4 4203.2 4204.6 4207.6 4207.7 4224.4 4267.8 4276.4 4279.2 4283.2 4286.8 4767.9 4865.5 4867.9 4870.2 4878.0 5735.9 5753.7 5757.0 5771.2 5776.0 1502.6 1526.2 1526.8 1529.6 1531.4 1035.3 1037.3 1046.8 1052.2 1059.4 5011.6 5022.7 5024.6 5033.4 5034.4 5985.4 5991.4 5998.0 6002.2 6007.8 4998.8 4998.9 5017.4 5035.6 5050.6 3141.9 3209.1 3225.9 3227.9 3243.7 5455.9 5643.8 5651.5 5652.4 5653.7 5977.9 6017.2 6226.1 6244.0 6244.0 5665.3 5719.8 5725.5 5737.8 5748.3 6018.9 6025.9 6032.9 6039.7 6039.8 5732.7 5913.5 5914.4 5923.9 5937.4 5673.4 5677.4 5707.5 5709.3 5724.9 4060.4 4091.8 4097.2 4105.1 4109.1 5842.5 6002.5 6002.8 6010.7 6034.1 5807.4 5815.8 5823.3 5832.9 5835.2 5785.3 5805.4 5818.1 5825.8 5832.0 5512.4 5683.9 5698.7 5701.9 5702.3 5795.2 5812.3 5845.0 5849.2 5856.8 5677.2 5683.0 5687.9 5692.1 5696.0 19:28:38 INFO - PROCESS | 24056 | 19:28:38 INFO - PROCESS | 24056 | [#5] yui.html Cycles:180 Average:11443.13 Median:631.05 stddev:13075.74 (2072.1%) stddev-sans-first:13087.50 19:28:38 INFO - PROCESS | 24056 | Values: 693.5 731.4 779.4 784.5 794.4 11903.0 12049.3 12058.2 12077.1 12093.9 10740.9 10988.6 11622.1 11668.4 11721.2 745.6 755.3 760.0 760.4 760.7 758.3 759.7 760.3 760.7 763.2 783.4 785.9 786.1 788.5 793.1 776.6 781.3 782.4 783.0 786.8 586.1 588.8 589.5 589.6 591.1 10874.2 10999.8 11022.7 11054.7 11061.0 9732.6 9767.1 9785.8 10032.8 10058.4 8472.2 8780.5 8864.0 8975.4 9028.9 3040.6 3064.2 3098.0 3183.3 3242.7 37573.6 42687.0 44167.0 44360.0 44551.0 9581.7 9607.9 9649.4 9652.1 9750.1 15909.4 15962.7 15986.0 16008.8 16025.2 6431.2 6505.1 6510.6 6703.8 6721.9 3690.4 3691.3 3712.5 3773.0 3774.1 2548.2 2560.5 2570.4 2624.3 2625.0 466.5 473.0 473.4 477.8 479.3 495.8 539.7 552.3 560.5 610.1 7506.1 7586.5 7703.8 7845.8 7962.9 542.9 605.0 605.0 621.9 640.2 3416.7 3482.6 3582.7 3603.8 3610.7 46312.5 46485.5 46851.8 46884.8 47062.0 38311.4 38422.8 38438.0 38442.8 38637.2 32530.3 38517.4 38610.0 40127.8 40230.2 7010.7 7189.5 7970.6 8017.0 8636.7 27528.7 28154.6 29523.0 29820.7 29897.4 36905.8 37446.0 37510.2 37580.4 38331.4 7808.1 8193.0 8258.6 8568.9 8570.2 9517.1 9589.1 9630.4 9730.9 9976.5 8390.5 8704.3 8721.1 8730.3 8791.6 8766.0 8873.6 8963.6 9027.2 9301.4 8314.1 8399.1 8483.1 8539.3 8546.8 7627.0 7730.3 7793.7 7892.5 8059.7 7266.2 7919.2 7962.2 8061.7 8088.7 19:28:38 INFO - PROCESS | 24056 | -------- Summary: end -------- 19:28:38 INFO - PROCESS | 24056 | 19:28:39 INFO - TEST-INFO | 24056: exit 0 19:28:39 INFO - TEST-OK | dromaeo_css | took 1112796ms 19:28:39 INFO - TEST-START | kraken 19:28:39 INFO - operating with platform_type : linux_ 19:28:39 INFO - Initialising browser for kraken test... 19:28:39 INFO - TEST-INFO | started process 24301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAiG61a/profile http://localhost:49311/getInfo.html) 19:28:43 INFO - PROCESS | 24301 | 19:28:43 INFO - PROCESS | 24301 | (process:24374): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:43 INFO - PROCESS | 24301 | __metrics Screen width/height:1600/1200 19:28:43 INFO - PROCESS | 24301 | colorDepth:24 19:28:43 INFO - PROCESS | 24301 | Browser inner width/height: 1024/697 19:28:43 INFO - PROCESS | 24301 | __metrics 19:28:44 INFO - PROCESS | 24301 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:28:44 INFO - TEST-INFO | 24301: exit 0 19:28:44 INFO - Browser initialized. 19:28:44 INFO - Running cycle 1/1 for kraken test... 19:28:44 INFO - TEST-INFO | started process 24423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAiG61a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:46 INFO - PROCESS | 24423 | 19:28:46 INFO - PROCESS | 24423 | (process:24479): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:56 INFO - PROCESS | 24423 | RSS: Main: 150466560 19:28:56 INFO - PROCESS | 24423 | 19:28:59 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:00 INFO - PROCESS | 24423 | RSS: Main: 150142976 19:29:00 INFO - PROCESS | 24423 | 19:29:02 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-dft) 19:29:03 INFO - PROCESS | 24423 | RSS: Main: 152834048 19:29:03 INFO - PROCESS | 24423 | 19:29:06 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-fft) 19:29:07 INFO - PROCESS | 24423 | RSS: Main: 146010112 19:29:07 INFO - PROCESS | 24423 | 19:29:09 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-oscillator) 19:29:09 INFO - PROCESS | 24423 | RSS: Main: 147943424 19:29:09 INFO - PROCESS | 24423 | 19:29:12 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49311/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:29:12 INFO - PROCESS | 24423 | RSS: Main: 147374080 19:29:12 INFO - PROCESS | 24423 | 19:29:15 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49311/tests/kraken/driver.html?testName=imaging-darkroom) 19:29:16 INFO - PROCESS | 24423 | RSS: Main: 148729856 19:29:16 INFO - PROCESS | 24423 | 19:29:19 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49311/tests/kraken/driver.html?testName=imaging-desaturate) 19:29:20 INFO - PROCESS | 24423 | RSS: Main: 148566016 19:29:20 INFO - PROCESS | 24423 | 19:29:23 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49311/tests/kraken/driver.html?testName=json-parse-financial) 19:29:23 INFO - PROCESS | 24423 | RSS: Main: 148606976 19:29:23 INFO - PROCESS | 24423 | 19:29:25 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49311/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:29:26 INFO - PROCESS | 24423 | RSS: Main: 147734528 19:29:26 INFO - PROCESS | 24423 | 19:29:28 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:29:28 INFO - PROCESS | 24423 | RSS: Main: 149024768 19:29:28 INFO - PROCESS | 24423 | 19:29:30 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:29:31 INFO - PROCESS | 24423 | RSS: Main: 148230144 19:29:31 INFO - PROCESS | 24423 | 19:29:34 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:29:34 INFO - PROCESS | 24423 | RSS: Main: 149331968 19:29:34 INFO - PROCESS | 24423 | 19:29:37 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:29:37 INFO - PROCESS | 24423 | RSS: Main: 148852736 19:29:37 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49311/tests/kraken/driver.html?testName=ai-astar) 19:29:39 INFO - PROCESS | 24423 | RSS: Main: 149426176 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | __start_tp_report 19:29:39 INFO - PROCESS | 24423 | _x_x_mozilla_page_load 19:29:39 INFO - PROCESS | 24423 | _x_x_mozilla_page_load_details 19:29:39 INFO - PROCESS | 24423 | |i|pagename|runs| 19:29:39 INFO - PROCESS | 24423 | |0;ai-astar;114;109;117;114;113;125;115;113;114;115 19:29:39 INFO - PROCESS | 24423 | |1;audio-beat-detection;175;131;153;180;131;151;162;140;176;135 19:29:39 INFO - PROCESS | 24423 | |2;audio-dft;166;164;163;166;163;165;164;163;166;162 19:29:39 INFO - PROCESS | 24423 | |3;audio-fft;74;73;73;73;143;74;72;73;76;154 19:29:39 INFO - PROCESS | 24423 | |4;audio-oscillator;100;98;137;97;97;97;139;97;98;140 19:29:39 INFO - PROCESS | 24423 | |5;imaging-gaussian-blur;110;110;109;110;110;110;110;109;110;109 19:29:39 INFO - PROCESS | 24423 | |6;imaging-darkroom;149;149;149;147;149;148;148;148;147;150 19:29:39 INFO - PROCESS | 24423 | |7;imaging-desaturate;96;96;97;97;98;95;96;96;96;96 19:29:39 INFO - PROCESS | 24423 | |8;json-parse-financial;70;81;71;71;72;69;70;78;70;68 19:29:39 INFO - PROCESS | 24423 | |9;json-stringify-tinderbox;65;67;67;67;67;67;66;66;67;66 19:29:39 INFO - PROCESS | 24423 | |10;stanford-crypto-aes;83;86;85;85;98;84;86;85;84;84 19:29:39 INFO - PROCESS | 24423 | |11;stanford-crypto-ccm;128;139;121;129;122;127;125;121;123;128 19:29:39 INFO - PROCESS | 24423 | |12;stanford-crypto-pbkdf2;136;149;150;148;162;148;149;147;147;134 19:29:39 INFO - PROCESS | 24423 | |13;stanford-crypto-sha256-iterative;71;73;76;71;73;72;71;69;70;69 19:29:39 INFO - PROCESS | 24423 | __end_tp_report 19:29:39 INFO - PROCESS | 24423 | __start_cc_report 19:29:39 INFO - PROCESS | 24423 | _x_x_mozilla_cycle_collect,796 19:29:39 INFO - PROCESS | 24423 | __end_cc_report 19:29:39 INFO - PROCESS | 24423 | __startTimestamp1452742179887__endTimestamp 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | ------- Summary: start ------- 19:29:39 INFO - PROCESS | 24423 | Number of tests: 14 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.50 stddev:4.09 (3.6%) stddev-sans-first:4.33 19:29:39 INFO - PROCESS | 24423 | Values: 114.0 109.0 117.0 114.0 113.0 125.0 115.0 113.0 114.0 115.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:157.50 stddev:19.11 (12.1%) stddev-sans-first:18.60 19:29:39 INFO - PROCESS | 24423 | Values: 175.0 131.0 153.0 180.0 131.0 151.0 162.0 140.0 176.0 135.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:1.48 (0.9%) stddev-sans-first:1.41 19:29:39 INFO - PROCESS | 24423 | Values: 166.0 164.0 163.0 166.0 163.0 165.0 164.0 163.0 166.0 162.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#3] audio-fft Cycles:10 Average:88.50 Median:73.00 stddev:31.75 (43.5%) stddev-sans-first:33.24 19:29:39 INFO - PROCESS | 24423 | Values: 74.0 73.0 73.0 73.0 143.0 74.0 72.0 73.0 76.0 154.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:97.00 stddev:19.82 (20.4%) stddev-sans-first:20.68 19:29:39 INFO - PROCESS | 24423 | Values: 100.0 98.0 137.0 97.0 97.0 97.0 139.0 97.0 98.0 140.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:29:39 INFO - PROCESS | 24423 | Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 19:29:39 INFO - PROCESS | 24423 | Values: 149.0 149.0 149.0 147.0 149.0 148.0 148.0 148.0 147.0 150.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 19:29:39 INFO - PROCESS | 24423 | Values: 96.0 96.0 97.0 97.0 98.0 95.0 96.0 96.0 96.0 96.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#8] json-parse-financial Cycles:10 Average:72.00 Median:71.00 stddev:4.16 (5.9%) stddev-sans-first:4.35 19:29:39 INFO - PROCESS | 24423 | Values: 70.0 81.0 71.0 71.0 72.0 69.0 70.0 78.0 70.0 68.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 19:29:39 INFO - PROCESS | 24423 | Values: 65.0 67.0 67.0 67.0 67.0 67.0 66.0 66.0 67.0 66.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:4.32 (5.1%) stddev-sans-first:4.44 19:29:39 INFO - PROCESS | 24423 | Values: 83.0 86.0 85.0 85.0 98.0 84.0 86.0 85.0 84.0 84.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:127.50 stddev:5.40 (4.2%) stddev-sans-first:5.69 19:29:39 INFO - PROCESS | 24423 | Values: 128.0 139.0 121.0 129.0 122.0 127.0 125.0 121.0 123.0 128.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:148.50 stddev:7.70 (5.2%) stddev-sans-first:7.07 19:29:39 INFO - PROCESS | 24423 | Values: 136.0 149.0 150.0 148.0 162.0 148.0 149.0 147.0 147.0 134.0 19:29:39 INFO - PROCESS | 24423 | 19:29:39 INFO - PROCESS | 24423 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:2.12 (3.0%) stddev-sans-first:2.24 19:29:39 INFO - PROCESS | 24423 | Values: 71.0 73.0 76.0 71.0 73.0 72.0 71.0 69.0 70.0 69.0 19:29:39 INFO - PROCESS | 24423 | -------- Summary: end -------- 19:29:39 INFO - PROCESS | 24423 | 19:29:40 INFO - TEST-INFO | 24423: exit 0 19:29:40 INFO - TEST-OK | kraken | took 61592ms 19:29:40 INFO - TEST-START | v8_7 19:29:40 INFO - operating with platform_type : linux_ 19:29:40 INFO - Initialising browser for v8_7 test... 19:29:40 INFO - TEST-INFO | started process 24707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM34K8Q/profile http://localhost:49311/getInfo.html) 19:29:44 INFO - PROCESS | 24707 | 19:29:44 INFO - PROCESS | 24707 | (process:24780): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:29:45 INFO - PROCESS | 24707 | __metrics Screen width/height:1600/1200 19:29:45 INFO - PROCESS | 24707 | colorDepth:24 19:29:45 INFO - PROCESS | 24707 | Browser inner width/height: 1024/697 19:29:45 INFO - PROCESS | 24707 | __metrics 19:29:45 INFO - PROCESS | 24707 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:29:46 INFO - TEST-INFO | 24707: exit 0 19:29:46 INFO - Browser initialized. 19:29:46 INFO - Running cycle 1/1 for v8_7 test... 19:29:46 INFO - TEST-INFO | started process 24829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM34K8Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:48 INFO - PROCESS | 24829 | 19:29:48 INFO - PROCESS | 24829 | (process:24887): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:29:58 INFO - PROCESS | 24829 | RSS: Main: 150409216 19:29:58 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | Cycle 1(1): loaded http://localhost:49311/tests/v8_7/run.html (next: http://localhost:49311/tests/v8_7/run.html) 19:30:21 INFO - PROCESS | 24829 | RSS: Main: 145723392 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | __start_tp_report 19:30:21 INFO - PROCESS | 24829 | _x_x_mozilla_page_load 19:30:21 INFO - PROCESS | 24829 | _x_x_mozilla_page_load_details 19:30:21 INFO - PROCESS | 24829 | |i|pagename|runs| 19:30:21 INFO - PROCESS | 24829 | |0;Richards;166.16816218012627 19:30:21 INFO - PROCESS | 24829 | |1;DeltaBlue;188.78610534264678 19:30:21 INFO - PROCESS | 24829 | |2;Encrypt;279.87685418415896 19:30:21 INFO - PROCESS | 24829 | |3;Decrypt;5208.333333333333 19:30:21 INFO - PROCESS | 24829 | |4;RayTrace;1066.0980810234541 19:30:21 INFO - PROCESS | 24829 | |5;Earley;765.1109410864575 19:30:21 INFO - PROCESS | 24829 | |6;Boyer;12144.578313253012 19:30:21 INFO - PROCESS | 24829 | |7;RegExp;43000 19:30:21 INFO - PROCESS | 24829 | |8;Splay;602.1634615384615 19:30:21 INFO - PROCESS | 24829 | |9;NavierStokes;4826.923076923077 19:30:21 INFO - PROCESS | 24829 | __end_tp_report 19:30:21 INFO - PROCESS | 24829 | __startTimestamp1452742221300__endTimestamp 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | ------- Summary: start ------- 19:30:21 INFO - PROCESS | 24829 | Number of tests: 10 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 166.2 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#1] DeltaBlue Cycles:1 Average:188.79 Median:188.79 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 188.8 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 279.9 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 5208.3 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 1066.1 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#5] Earley Cycles:1 Average:765.11 Median:765.11 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 765.1 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 12144.6 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#7] RegExp Cycles:1 Average:43000.00 Median:43000.00 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 43000.0 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#8] Splay Cycles:1 Average:602.16 Median:602.16 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 602.2 19:30:21 INFO - PROCESS | 24829 | 19:30:21 INFO - PROCESS | 24829 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 19:30:21 INFO - PROCESS | 24829 | Values: 4826.9 19:30:21 INFO - PROCESS | 24829 | -------- Summary: end -------- 19:30:21 INFO - PROCESS | 24829 | 19:30:22 INFO - TEST-INFO | 24829: exit 0 19:30:22 INFO - TEST-OK | v8_7 | took 41304ms 19:30:22 INFO - SUITE-END | took 1215s 19:30:22 INFO - Completed test suite (00:20:15) 19:30:22 INFO - Working with test: dromaeo_css 19:30:22 INFO - Generating results file: dromaeo_css 19:30:22 INFO - Working with test: kraken 19:30:22 INFO - Generating results file: kraken 19:30:22 INFO - javascript benchmark 19:30:22 INFO - Working with test: v8_7 19:30:22 INFO - Generating results file: v8_7 19:30:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:30:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 19:30:22 INFO - process_Request line: dromaeo_css 6046.03 graph.html#tests=[[72,94,43]] 19:30:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:30:22 INFO - process_Request line: kraken 1554.70 graph.html#tests=[[232,94,43]] 19:30:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:30:22 INFO - process_Request line: v8_7 20177.38 graph.html#tests=[[230,94,43]] 19:30:22 INFO - RETURN: dromaeo_css: 6046.03 19:30:22 INFO - RETURN: kraken: 1554.70 19:30:22 INFO - RETURN: v8_7: 20177.38 19:30:22 INFO - javascript benchmark 19:30:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2537.08664880643, 2592.0798116668593, 2614.6078088286754, 2617.9083732069394, 2635.617835413864, 4291.184674911765, 4466.151431228064, 4481.5070342262325, 4487.237169681154, 4498.100379924012, 4315.590018948203, 4409.228385032615, 4434.113177364524, 4435.512093669694, 4435.911281774371, 188.59637791613912, 4060.8578699745517, 4064.552899181088, 4095.795210239491, 4151.73013754105, 3828.349180639284, 4011.5587285398583, 4034.939475907849, 4046.858359957402, 4081.857135000276, 4033.0925541753163, 4052.1085361220485, 4052.6757859371473, 4087.2438598859308, 4100.261952848486, 3922.921541569153, 3988.481497405348, 4100.0569868930015, 4107.938380924288, 4150.709450338478, 4006.9198616027807, 4042.8787136385954, 4069.552349241581, 4088.795560221977, 4100.138970816102, 4288.056627541936, 4311.784410779448, 4332.1985432695055, 4350.347447882843, 4397.7361358318285, 4494.280915053576, 4589.0, 4708.364370809931, 4712.151812673717, 4742.193827049376, 4655.697379670344, 4681.906361872778, 4688.038952014829, 4707.270373092142, 4727.432708075053, 4341.2836881914445, 4359.760213188273, 4361.345798130305, 4367.10474352757, 4400.405945197389, 4669.4630117536235, 4737.24204127338, 4765.404324459442, 4773.570378665937, 4863.124637565272, 4571.862844114682, 4580.541945805459, 4583.839565615254, 4588.587027167504, 4604.861854144381, 4660.39414876064, 4679.134360143385, 4679.789409476582, 4697.976510117427, 4718.882027949328, 4432.49026361966, 4552.453705555355, 4552.931706024412, 4564.2012647786505, 4565.680402371802, 4574.611158051536, 4599.5400459953735, 4614.861554153381, 4625.444946606362, 4663.743494107789, 3965.7025723070883, 3994.6005399459823, 3999.0202400412086, 4004.6395824375945, 4036.394540818842, 3408.829558522064, 3415.9829200853837, 3486.4247399178853, 3507.0706262840367, 3548.503209550665, 4083.571225021389, 4100.466939297872, 4101.835926562904, 4108.0, 4139.751614903115, 4684.672072954861, 4692.812287508462, 4694.976525117352, 4695.694779839299, 4738.905221895543, 3945.9802700986884, 4019.93970090443, 4024.0, 4097.651699605507, 4152.045029643199, 4215.515215750228, 4215.747055176699, 4226.070264541796, 4233.534311225762, 4268.210381079511, 4486.977565112154, 4499.842505512292, 4544.477385100689, 4547.772611369484, 4598.517155698671, 4457.04173602677, 4522.3442600823355, 4532.32015197723, 4737.763111844463, 4777.21176005969, 4541.84103556374, 4549.044700612776, 4550.180967425895, 4564.041551274269, 4585.6102231310715, 4654.418197725285, 4659.720416775004, 4683.391159149289, 4726.220173671443, 4730.905381892412, 4470.821167153277, 4596.793144308447, 4602.562756538124, 4605.562471565196, 4743.383360163295, 4468.240399132091, 4505.3692483053055, 4509.706869053501, 4523.932141017822, 4537.069900670421, 4534.501204867528, 4538.614217791393, 4543.909121817611, 4570.657200709894, 4596.126735920165, 4349.543297953669, 4417.580329868657, 4464.50890402062, 4477.1493416250805, 4482.238019536621, 4465.397171381952, 4480.39514665516, 4595.770211489479, 4650.441946966385, 4681.929771053369, 4443.955670417514, 4449.377087207728, 4449.644028477649, 4459.197344478025, 4488.5960263576435], "unit": "score", "name": "dojo.html", "value": 4282.571908776303}, {"lowerIsBetter": false, "replicates": [492.15595254139123, 508.56263613292583, 529.4308618235398, 539.649228001799, 546.721172202177, 31794.20514487139, 32508.67491325086, 32554.99999999997, 32598.511022334653, 32639.1840203995, 35712.46431303533, 36307.0, 36354.63645363545, 36397.63602363975, 36426.271474570494, 7611.54330740156, 7764.767056988299, 7767.184445633184, 7799.649015794274, 7801.907732917396, 7567.735129270477, 7703.3452156566755, 7727.768166955, 7864.882026769603, 7865.095514015876, 7844.0, 7864.056313242419, 7929.405294602899, 7931.365490760754, 7936.603169841514, 7764.689412423496, 7833.686652533892, 7836.490628109212, 7861.56761378124, 7861.646225919847, 7691.269329413697, 7735.110462296851, 7738.690452381898, 7796.883046754303, 7840.843183136305, 35445.0, 35680.46479302813, 35687.4646880297, 35841.283174336626, 36183.63816361829, 3066.0955018269665, 3084.475639141351, 3103.4103520331064, 3417.4532074868152, 3681.531134765528, 26600.60099098515, 26961.0, 27024.59463108055, 27051.45897082067, 27489.862550687318, 3059.3422414180836, 3118.5322201669705, 3166.0818362674795, 3184.0, 3198.4722520784044, 210083.0, 211558.0, 212352.0, 213228.0, 213784.0, 44961.550384495735, 46594.30108548375, 52400.0, 52739.0, 52748.73625631847, 54813.0, 55716.72141639266, 55835.44164558302, 56119.0, 56260.43739562634, 13491.730165396637, 13754.0, 13759.312034398241, 13773.724525509635, 13782.586522404345, 10441.530131144116, 10619.044286014296, 10629.734256643645, 10631.255812093079, 10642.36145831237, 17111.57221069483, 17338.826611733723, 17347.913260433616, 18265.63468730618, 18273.360432385067, 7036.577805331594, 7041.0846589944, 7241.348278654841, 7255.419566434673, 7272.63636818157, 891.2023738753909, 922.4234853216606, 930.1070971867083, 973.8977407372124, 981.8134554434635, 25101.24696259115, 25172.118975835758, 25415.36461588475, 25425.0, 25713.614295785577, 949.6486300069018, 957.9281553883486, 985.2265971212564, 996.6910257820099, 1089.3790539392628, 13131.934340328236, 13452.663683407993, 13661.726765464635, 13692.877603971401, 14493.492727754478, 253120.0, 257711.0, 258114.0, 259179.0, 259628.0, 41800.37299440511, 42860.35709464361, 43055.35416968748, 43075.56924430715, 43327.35008974868, 1227.018385291763, 1232.3406977267118, 1233.2538814017391, 1239.1202246405153, 1248.3009514671812, 25933.610995835454, 26062.087826925967, 26232.0, 26400.339991500365, 26404.0, 38715.41926871043, 39112.21775564416, 39166.608333916294, 39284.41073383844, 39291.60708392879, 233082.0, 235826.0, 236005.0, 236251.0, 236599.0, 25079.24762257135, 25735.871320643277, 26487.470250595266, 27092.187234383, 27130.593041104796, 31568.36863262676, 31889.0, 36942.26115477621, 37052.62947370492, 38052.0, 27203.0, 27469.31326716848, 27492.58761118625, 27871.442571148058, 28226.0, 27446.313842154104, 29519.55720664235, 30141.849290753406, 30762.384752305275, 31170.844145779127, 30503.542446863758, 31015.844920775253, 31289.217769555944, 31352.37295254128, 31413.685863141076, 25938.481230375663, 28291.43417131687, 28364.716352836207, 28377.0, 28390.85804570964, 22627.773722262566, 22666.43333916665, 22730.0, 22800.65799012983, 22916.0], "unit": "score", "name": "ext.html", "value": 16145.206096666407}, {"lowerIsBetter": false, "replicates": [321.15055677732386, 322.4035534261616, 331.05648900633196, 331.9907481256979, 334.96161898115844, 13875.79186312205, 14437.422503099877, 14493.420263189473, 14732.33704483298, 15639.374425022985, 9449.858252126207, 9689.903100968988, 11158.888411115906, 14822.481213157515, 14857.0, 4438.489573699034, 4496.595306422421, 4642.442906851183, 4695.765211739416, 5103.642745007851, 4947.109520286347, 5040.1935690289565, 5063.468335824722, 5078.0, 5081.618878584102, 3367.3770352484867, 3520.964790352102, 4879.487653796354, 5047.31861198739, 6130.44825965663, 6364.109024736541, 6498.5126115541525, 6533.0, 6637.734490620345, 6666.733330666768, 6317.968410157966, 6320.115183874262, 6332.398422149889, 6334.398232167937, 6347.174867267272, 18125.909370453195, 19735.40793776189, 20015.79984200154, 20215.79784202154, 20656.07047682858, 1838.3014454507202, 1856.786469556005, 1946.8247857692734, 1971.7338159348449, 2060.24800947653, 12862.163959342706, 13078.149920255248, 13130.934345328307, 13169.078164528486, 13244.735105297936, 1823.963520729578, 1840.2679286784162, 1887.4526387347653, 1888.6411581799414, 1893.2048539613395, 50520.242196367086, 51681.0, 53636.0, 53637.731811340695, 53713.19430208589, 14246.580820603187, 14517.637059073397, 14538.127712337293, 14547.78178327326, 14587.343569539396, 21715.131394744032, 21855.562888742137, 21884.12463501474, 21951.231706890183, 21988.560228795654, 8181.959090204511, 8183.386246031571, 8212.548309843016, 8378.24595786382, 8392.706255281037, 7002.159740831133, 7097.290270972965, 7251.202367739545, 7325.706971721072, 7331.046963894766, 7113.857722845514, 7201.96399018012, 7276.527025743309, 7345.228750981177, 7412.221716719775, 1707.812140664526, 2973.910782676523, 2990.5065664165604, 3015.0, 3067.2331917020747, 368.54852805313277, 380.423658157891, 388.615270881825, 742.38011260598, 845.6279237135641, 8681.435706679045, 9138.68014619485, 9449.811003779885, 9908.35595686278, 9950.452725100044, 392.1040422634324, 392.4760444806159, 392.7427534964603, 393.2155350076616, 868.70898249086, 7916.366690664733, 8020.759377218693, 8475.957620211982, 8859.64561417536, 9126.543672816333, 443815.0, 446663.0, 475398.0, 480636.0, 481992.0, 38356.04109897219, 38383.61616383856, 52190.73904630452, 62037.0, 62990.68504657447, 1057.5452555401098, 1069.652362982034, 1078.218291738499, 1083.1172594335592, 1087.5758454202867, 13886.93056534711, 13964.531205670051, 14025.3688584016, 14098.859011409755, 14156.150630962175, 26793.0, 27383.589246161722, 27600.585991209748, 29356.266093347836, 29869.70130298669, 32195.195120122185, 32202.35595288128, 32544.51183232301, 36957.26085478329, 37081.62918370782, 6065.696715164136, 6456.0, 6478.676066196577, 6516.609003459807, 6831.419329357061, 7980.401469889665, 9563.952180239332, 9602.85595716051, 9623.470709111067, 10352.0, 7680.731174408869, 7724.575148366894, 7780.299773020229, 7829.491083079582, 7880.802979925547, 8312.836202931716, 8318.251357377865, 8366.790830229293, 8546.145385461652, 8647.178518041028, 2583.134649892307, 2601.3366591519043, 5190.714510701797, 6591.670416479061, 8180.181981801772, 6340.809775706736, 6461.0, 6464.480847001045, 6607.603543787388, 6620.66896655175, 7522.8871566925445, 8362.45644033136, 8370.916290837014, 8405.201505856934, 8613.956930215309], "unit": "score", "name": "jquery.html", "value": 7538.057372242147}, {"lowerIsBetter": false, "replicates": [1391.5547024952016, 1397.8392484864237, 1503.751880939645, 1694.2375930831113, 1697.0666133626503, 6055.5155587553, 6225.5953363031485, 6682.599044057354, 6931.618760968151, 6959.0953176087105, 6815.522913396064, 7069.964650176755, 7130.572165670063, 7140.785776426703, 7155.677994490247, 1938.5832046110083, 1966.2921348314596, 1967.7048442733633, 1968.252064215596, 1970.8916009619466, 1994.3219305436148, 2017.3241963942096, 2029.0666293504933, 2032.9695054574192, 2055.0341339570455, 1976.9209231630718, 1987.7912819153998, 1998.2906068345746, 2006.769221539527, 2010.698395240711, 2036.6741321388506, 2040.143139881246, 2041.8264447521979, 2042.2137477071285, 2047.119738512439, 2010.447127040061, 2045.3761602711168, 2084.6768750843644, 2090.0281369163413, 2091.393495886191, 7285.599292038935, 7291.34377905991, 7348.522346047544, 7352.375048120916, 7383.2247614000835, 4009.6190861868076, 4062.8781136565653, 4074.8370065197355, 4087.89780255493, 4126.504819421689, 2432.221689059502, 2461.0155937624913, 2497.500499900009, 2662.826916250457, 2663.893444262227, 799.3365506629542, 800.0639252075086, 813.6419975210947, 814.9837003259961, 816.6855760532178, 9790.804183916282, 9848.310618256724, 9861.60553577856, 9921.702348929544, 10048.995100489965, 3617.439296908983, 3631.9636803631624, 3647.252313275772, 3685.760425572329, 3701.148735790783, 8616.138386161334, 8628.52543110135, 8633.870491942625, 8685.348598855111, 8692.348073894484, 3935.8622448214173, 3978.0651546886456, 3979.263836190314, 3985.5416627087675, 3987.222491614107, 3196.696313850227, 3262.624798148196, 3599.2441587266967, 3634.0733113056003, 3650.671439570451, 3233.7736358455154, 3266.6896644818703, 3270.329582435595, 3274.2141885947676, 3286.6877646623534, 999.8000399919899, 1009.7475631092227, 1012.6759436980243, 1020.5560581147224, 1042.838360054193, 811.5090370325986, 823.7446391618618, 920.9861852072224, 1055.0820785916303, 1059.5814653212092, 6528.445082167974, 6536.477081833442, 6569.67151642416, 6588.0, 6744.291849355845, 1013.4172850610928, 1018.1091544898214, 1021.7547788530848, 1027.5632856036154, 1044.5456226541478, 5170.870728231825, 5232.581393488512, 5234.18870075139, 5249.580033597303, 5251.343582052244, 8569.742907712778, 8674.132586741402, 9142.542872856331, 9145.725628231165, 9192.31057670664, 8938.642454301755, 8958.731238062868, 8971.19259266656, 8983.101689830964, 8984.640614375483, 6468.482521398371, 6571.244306904767, 6619.0, 6663.233728121328, 6674.699638516278, 6242.500599952084, 6256.655883926428, 6308.495320374451, 6314.84212894663, 6315.273743519554, 7388.445866559922, 7474.738384156529, 7484.850302993801, 7495.213002634645, 7512.661930213044, 7384.150822655463, 7653.387728981556, 7669.233076692286, 7690.461667683208, 7708.229177082471, 5276.261323414648, 5417.187421886749, 6114.541409394402, 6257.499400047895, 6283.59156654816, 6511.869762604816, 6638.668066596748, 6652.068710380454, 6655.434288085567, 6707.832304192434, 6328.588641738273, 6428.19647544057, 6513.772017979348, 6553.115329430466, 6608.0, 6321.683915804283, 6376.585521941244, 6381.0, 6427.100205971261, 6492.0261960706275, 6389.456896163692, 6448.161738973903, 6466.935330646634, 6477.481801455967, 6480.902786458301, 5645.689487078086, 5665.065264231521, 5707.914381284201, 5724.513416359656, 5764.279465066867, 5915.526757859275, 6022.819315420545, 6028.276606807036, 6045.365236650265, 6077.149199112217], "unit": "score", "name": "mootools.html", "value": 3999.8242000315145}, {"lowerIsBetter": false, "replicates": [299.4669488310807, 310.8849725601528, 312.30512110554014, 318.83898631191244, 321.44550650128514, 5460.836174914754, 5542.778288868445, 5556.611037227391, 5592.049351610226, 5598.552115830734, 5430.782768689248, 5454.10007348787, 5479.726013699319, 5509.393966663663, 5527.060399732045, 4056.574059723731, 4186.79066046698, 4268.295731204355, 4276.486821581415, 4287.528371879091, 4171.8539851105215, 4180.310248808943, 4184.121334519755, 4187.51843537994, 4202.474690663667, 4153.958460415387, 4155.563665815092, 4157.792110394468, 4160.105577300879, 4160.417541544171, 4196.664266858644, 4200.537940826506, 4201.579842015789, 4204.894877628053, 4212.262854000568, 3645.0887278180453, 3671.118931456458, 3671.7429779915415, 3672.173760903802, 3679.098620837885, 5150.896982060338, 5190.169572868361, 5216.374035115772, 5224.320838290998, 5255.737213139328, 4843.782029808632, 4875.07373599015, 4881.5606595406225, 4885.633577481668, 4899.387576552931, 5757.453041961007, 5763.423657634245, 5766.740496677659, 5768.048272035109, 5799.18811366409, 3955.3275943089743, 4041.009952561641, 4053.574374690674, 4069.4302797608357, 4069.837206511736, 5974.522038236931, 6035.758569657209, 6049.0, 6054.757809687651, 6060.36366181549, 4203.243416185116, 4204.558521355275, 4207.558206388285, 4207.705460617727, 4224.408582798411, 4267.765272909957, 4276.444062271885, 4279.165562715303, 4283.164782867311, 4286.764227967492, 4767.880802979953, 4865.513448655177, 4867.9269810952865, 4870.196417591129, 4877.975610121926, 5735.913961290584, 5753.683547404933, 5757.0, 5771.249737534094, 5775.971120144372, 1502.6168327076525, 1526.2368815592204, 1526.7938828258043, 1529.5946574157856, 1531.4104069932932, 1035.30634474902, 1037.2946396450336, 1046.7592453735683, 1052.2318707343682, 1059.369675043348, 5011.6241281904, 5022.723750193774, 5024.57291130258, 5033.446320904697, 5034.395872495324, 5985.401459854067, 5991.400859913973, 5998.0, 6002.189704389852, 6007.849803754853, 4998.825041123616, 4998.8502644391265, 5017.397912250481, 5035.62232832539, 5050.646454748133, 3141.874325026973, 3209.069369882708, 3225.935481290408, 3227.9193020174685, 3243.7080662739995, 5455.945440545624, 5643.7742490299925, 5651.463111004448, 5652.406497317723, 5653.745581448762, 5977.880442391128, 6017.187679663277, 6226.128342032119, 6243.969744992026, 6244.0, 5665.348484924287, 5719.828405147769, 5725.484706376446, 5737.770489180386, 5748.281464816898, 6018.909716354171, 6025.939740602538, 6032.90950635732, 6039.667818270037, 6039.818805435844, 5732.713364331683, 5913.46778789911, 5914.378990205966, 5923.911141332797, 5937.406259374028, 5673.432656734293, 5677.3754886963225, 5707.543396528351, 5709.25779648643, 5724.914126288192, 4060.4112403700706, 4091.774952377648, 4097.160082183205, 4105.096878686684, 4109.137081212979, 5842.474177324061, 6002.459778619946, 6002.759889604367, 6010.669413182317, 6034.125051867367, 5807.361190268983, 5815.79644712433, 5823.301203855564, 5832.883342333044, 5835.241418615553, 5785.305763308262, 5805.390434004537, 5818.0981947798155, 5825.825225243249, 5832.0085585451425, 5512.373136042082, 5683.8863222736145, 5698.6580805151825, 5701.857453563694, 5702.34423041339, 5795.217645617788, 5812.3025236971835, 5844.970775146097, 5849.210356601804, 5856.765729370948, 5677.1768093627015, 5682.971585142048, 5687.914681279867, 5692.060809966475, 5695.971520142372], "unit": "score", "name": "prototype.html", "value": 4345.162987090857}, {"lowerIsBetter": false, "replicates": [693.5110746923416, 731.4331393170293, 779.4465929190276, 784.5332027443669, 794.4240425691374, 11903.0, 12049.337286449241, 12058.155929084967, 12077.094217933669, 12093.879061209396, 10740.87220841812, 10988.560457581707, 11622.07023438125, 11668.35824029678, 11721.179517433782, 745.6085555083583, 755.2560727683227, 760.0195747485736, 760.4486747108358, 760.7147319755092, 758.2758465665304, 759.654357267442, 760.3271105071996, 760.7185341423653, 763.2405756272517, 783.4085265624445, 785.9135495095535, 786.1195461083565, 788.538704857659, 793.1275596843454, 776.5651235308218, 781.3358645151604, 782.3897360059163, 783.0212234706617, 786.7757689058648, 586.1237450012259, 588.8027510783893, 589.4635881347996, 589.5813972079828, 591.1074277840492, 10874.18443616724, 10999.780004399867, 11022.669319920415, 11054.723631909186, 11061.0, 9732.610695572168, 9767.072128147815, 9785.810972211151, 10032.849507257397, 10058.446785426799, 8472.173164652679, 8780.473171609723, 8864.024957254696, 8975.416597921114, 9028.909710902873, 3040.5743195952587, 3064.1879901826032, 3097.9535306970415, 3183.3474137801695, 3242.659520750311, 37573.62426375729, 42687.0, 44167.0, 44360.0, 44551.0, 9581.712548623553, 9607.855882161633, 9649.372790768577, 9652.131308182297, 9750.122488975885, 15909.363625455084, 15962.680746385007, 15986.0, 16008.839911600968, 16025.198740063184, 6431.163948686734, 6505.121808555879, 6510.641914694643, 6703.798886033427, 6721.899171512431, 3690.3605152353084, 3691.2617476504806, 3712.461693054492, 3772.962435330251, 3774.0753515388355, 2548.1718441506587, 2560.5135024345313, 2570.370259286487, 2624.265205742395, 2624.9868750656124, 466.45890766710454, 472.9739864307496, 473.4200604259754, 477.80410031887453, 479.2954357095065, 495.81902605548714, 539.6896784349015, 552.304096837987, 560.5039540007123, 610.0752127039199, 7506.13679426862, 7586.506877052974, 7703.845923081507, 7845.803854903673, 7962.880556791652, 542.9131338985743, 604.9546284028715, 604.9758009679564, 621.8631900981777, 640.2317219336815, 3416.6583341666133, 3482.6169121396624, 3582.7133829293593, 3603.837827297778, 3610.711143108545, 46312.53687463082, 46485.5351446488, 46851.765741171075, 46884.7655761719, 47062.0, 38311.42532862009, 38422.80788596095, 38437.99999999944, 38442.80778596089, 38637.2272554553, 32530.349393012006, 38517.42223866644, 38610.0, 40127.79936100301, 40230.19539609191, 7010.719571217094, 7189.496735228484, 7970.561619111005, 8017.0, 8636.697715580176, 27528.724712752617, 28154.577681335206, 29522.99999999914, 29820.70179298266, 29897.402051959274, 36905.815470923546, 37446.0, 37510.24979500449, 37580.436293456165, 38331.42502862515, 7808.063032436144, 8193.016837979481, 8258.628361723617, 8568.914310856811, 8570.185832345916, 9517.095875891779, 9589.136977672042, 9630.422174669542, 9730.854037189307, 9976.501174941079, 8390.496570205807, 8704.26013788835, 8721.127887211229, 8730.34522410809, 8791.648334066565, 8765.956170219108, 8873.600687969187, 8963.551822408723, 9027.187553120251, 9301.441913485212, 8314.127016663406, 8399.076101628938, 8483.10927352619, 8539.316854651737, 8546.78633034179, 7627.0, 7730.304272615492, 7793.688252469838, 7892.526448413114, 8059.677612895419, 7266.164391094881, 7919.16848730898, 7962.243586859239, 8061.717839875576, 8088.676452941816], "unit": "score", "name": "yui.html", "value": 5391.675181159989}], "name": "dromaeo_css", "value": 6046.031397399142}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 117.0, 114.0, 113.0, 125.0, 115.0, 113.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 114.9}, {"lowerIsBetter": true, "replicates": [175.0, 131.0, 153.0, 180.0, 131.0, 151.0, 162.0, 140.0, 176.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 153.4}, {"lowerIsBetter": true, "replicates": [166.0, 164.0, 163.0, 166.0, 163.0, 165.0, 164.0, 163.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 73.0, 143.0, 74.0, 72.0, 73.0, 76.0, 154.0], "unit": "score", "name": "audio-fft", "value": 88.5}, {"lowerIsBetter": true, "replicates": [100.0, 98.0, 137.0, 97.0, 97.0, 97.0, 139.0, 97.0, 98.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 149.0, 147.0, 149.0, 148.0, 148.0, 148.0, 147.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 98.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [70.0, 81.0, 71.0, 71.0, 72.0, 69.0, 70.0, 78.0, 70.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 85.0, 85.0, 98.0, 84.0, 86.0, 85.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [128.0, 139.0, 121.0, 129.0, 122.0, 127.0, 125.0, 121.0, 123.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [136.0, 149.0, 150.0, 148.0, 162.0, 148.0, 149.0, 147.0, 147.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 76.0, 71.0, 73.0, 72.0, 71.0, 69.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1554.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [188.78610534264678], "unit": "score", "name": "DeltaBlue", "value": 350.22704600000003}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [765.1109410864575], "unit": "score", "name": "Earley", "value": 871.0671410000003}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [43000.0], "unit": "score", "name": "RegExp", "value": 21.185697674418595}, {"lowerIsBetter": false, "replicates": [602.1634615384615], "unit": "score", "name": "Splay", "value": 135.3303632734531}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20177.380046957795}]} 19:30:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20177.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1554.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6046.03"}}} 19:30:22 INFO - Return code: 0 19:30:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:30:22 INFO - # TBPL SUCCESS # 19:30:22 INFO - Running post-action listener: _resource_record_post_action 19:30:22 INFO - Running post-run listener: _resource_record_post_run 19:30:23 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 541233152; Read time: 0; Write time: 363396 19:30:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 231190528; Read time: 0; Write time: 203924 19:30:23 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 309178368; Read time: 0; Write time: 159428 19:30:23 INFO - Running post-run listener: _upload_blobber_files 19:30:23 INFO - Blob upload gear active. 19:30:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:30:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:30:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:30:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:30:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:30:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:30:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:25 INFO - (blobuploader) - INFO - Done attempting. 19:30:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:30:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:30:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:26 INFO - (blobuploader) - INFO - Done attempting. 19:30:26 INFO - (blobuploader) - INFO - Iteration through files over. 19:30:26 INFO - Return code: 0 19:30:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:30:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:30:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8d4c1f2188fea4e5f2a22a781a879630011acee95e5610ba6e2af67971edf0f0c395081df31133052570152cd2bc50a00dcdea0b28e21beb1ebd129cdfd1d7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8936067ad1c71b452966ba275cb88ce19a9fc60225c7b538c7e037f3eba15df712898d5fc418aa515cd798b412a6f0e17b8dc4e5c0cafb66d3653bf631a3d9f2"} 19:30:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:30:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:30:26 INFO - Contents: 19:30:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8d4c1f2188fea4e5f2a22a781a879630011acee95e5610ba6e2af67971edf0f0c395081df31133052570152cd2bc50a00dcdea0b28e21beb1ebd129cdfd1d7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8936067ad1c71b452966ba275cb88ce19a9fc60225c7b538c7e037f3eba15df712898d5fc418aa515cd798b412a6f0e17b8dc4e5c0cafb66d3653bf631a3d9f2"} 19:30:26 INFO - Copying logs to upload dir... 19:30:26 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.499052 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-13 19:30:25.936379) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 19:30:25.940030) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761 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/f8d4c1f2188fea4e5f2a22a781a879630011acee95e5610ba6e2af67971edf0f0c395081df31133052570152cd2bc50a00dcdea0b28e21beb1ebd129cdfd1d7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8936067ad1c71b452966ba275cb88ce19a9fc60225c7b538c7e037f3eba15df712898d5fc418aa515cd798b412a6f0e17b8dc4e5c0cafb66d3653bf631a3d9f2"} build_url:https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/VhAY7HQMQ5mvoXaAxxy53g/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/f8d4c1f2188fea4e5f2a22a781a879630011acee95e5610ba6e2af67971edf0f0c395081df31133052570152cd2bc50a00dcdea0b28e21beb1ebd129cdfd1d7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8936067ad1c71b452966ba275cb88ce19a9fc60225c7b538c7e037f3eba15df712898d5fc418aa515cd798b412a6f0e17b8dc4e5c0cafb66d3653bf631a3d9f2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 19:30:25.964427) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:30:25.964760) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452740942.813766-1603474761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:30:26.049309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 19:30:26.049638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 19:30:26.049934) ========= ========= Total master_lag: 0.32 =========