builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1451416464.46 results: success (0) buildid: 20151229103437 builduid: 7974188ae0f449ccaf6f3bcd5a8f3dd1 revision: 4ad0371b1a072e4153972e4cc76dc773b1e001b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.458028) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.458528) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.458918) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006295 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.488076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.488672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.552173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.552652) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.608636) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.608955) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.609356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.609707) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 11:14:24-- 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% 31.6M=0s 2015-12-29 11:14:24 (31.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159808 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.784731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.785275) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019505 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.840067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:24.840462) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4ad0371b1a072e4153972e4cc76dc773b1e001b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4ad0371b1a072e4153972e4cc76dc773b1e001b9 --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=9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 11:14:24,988 truncating revision to first 12 chars 2015-12-29 11:14:24,988 Setting DEBUG logging. 2015-12-29 11:14:24,988 attempt 1/10 2015-12-29 11:14:24,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/4ad0371b1a07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 11:14:25,254 unpacking tar archive at: b2g-inbound-4ad0371b1a07/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564632 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:25.420274) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:25.420623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:25.431215) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:25.431506) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 11:14:25.431933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-29 11:14:25.432306) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:25 INFO - MultiFileLogger online at 20151229 11:14:25 in /builds/slave/test 11:14:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 11:14:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:14:25 INFO - {'append_to_log': False, 11:14:25 INFO - 'base_work_dir': '/builds/slave/test', 11:14:25 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 11:14:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:14:25 INFO - 'branch': 'B2G-Inbound-Non-PGO', 11:14:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:25 INFO - 'config_files': ('talos/linux_config.py',), 11:14:25 INFO - 'default_actions': ('clobber', 11:14:25 INFO - 'read-buildbot-config', 11:14:25 INFO - 'download-and-extract', 11:14:25 INFO - 'populate-webroot', 11:14:25 INFO - 'create-virtualenv', 11:14:25 INFO - 'install', 11:14:25 INFO - 'run-tests'), 11:14:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:25 INFO - 'download_minidump_stackwalk': True, 11:14:25 INFO - 'download_symbols': 'ondemand', 11:14:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:14:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:14:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:14:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:14:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:25 INFO - 'installer_path': 'installer.exe', 11:14:25 INFO - 'log_level': 'info', 11:14:25 INFO - 'log_name': 'talos', 11:14:25 INFO - 'log_to_console': True, 11:14:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:25 INFO - 'opt_config_files': (), 11:14:25 INFO - 'pip_index': False, 11:14:25 INFO - 'sps_profile': False, 11:14:25 INFO - 'sps_profile_interval': 0, 11:14:25 INFO - 'suite': 'dromaeojs', 11:14:25 INFO - 'system_bits': '32', 11:14:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:25 INFO - 'title': 'talos-linux64-ix-036', 11:14:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:25 INFO - 'use_talos_json': True, 11:14:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:14:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:25 INFO - 'work_dir': 'build'} 11:14:25 INFO - ##### 11:14:25 INFO - ##### Running clobber step. 11:14:25 INFO - ##### 11:14:25 INFO - Running pre-action listener: _resource_record_pre_action 11:14:25 INFO - Running main action method: clobber 11:14:25 INFO - rmtree: /builds/slave/test/build 11:14:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:14:26 INFO - Running post-action listener: _resource_record_post_action 11:14:26 INFO - ##### 11:14:26 INFO - ##### Running read-buildbot-config step. 11:14:26 INFO - ##### 11:14:26 INFO - Running pre-action listener: _resource_record_pre_action 11:14:26 INFO - Running main action method: read_buildbot_config 11:14:26 INFO - Using buildbot properties: 11:14:26 INFO - { 11:14:26 INFO - "project": "", 11:14:26 INFO - "product": "firefox", 11:14:26 INFO - "script_repo_revision": "production", 11:14:26 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 11:14:26 INFO - "repository": "", 11:14:26 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 11:14:26 INFO - "buildid": "20151229103437", 11:14:26 INFO - "pgo_build": "False", 11:14:26 INFO - "basedir": "/builds/slave/test", 11:14:26 INFO - "buildnumber": 804, 11:14:26 INFO - "slavename": "talos-linux64-ix-036", 11:14:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:14:26 INFO - "platform": "ubuntu64_hw", 11:14:26 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 11:14:26 INFO - "branch": "b2g-inbound", 11:14:26 INFO - "repo_path": "integration/b2g-inbound", 11:14:26 INFO - "revision": "4ad0371b1a072e4153972e4cc76dc773b1e001b9", 11:14:26 INFO - "stage_platform": "linux64", 11:14:26 INFO - "builduid": "7974188ae0f449ccaf6f3bcd5a8f3dd1", 11:14:26 INFO - "slavebuilddir": "test" 11:14:26 INFO - } 11:14:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:14:26 INFO - Running post-action listener: _resource_record_post_action 11:14:26 INFO - ##### 11:14:26 INFO - ##### Running download-and-extract step. 11:14:26 INFO - ##### 11:14:26 INFO - Running pre-action listener: _resource_record_pre_action 11:14:26 INFO - Running main action method: download_and_extract 11:14:26 INFO - mkdir: /builds/slave/test/build/tests 11:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:26 INFO - https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/test_packages.json 11:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/test_packages.json 11:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:14:26 INFO - Downloaded 1302 bytes. 11:14:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:14:26 INFO - Using the following test package requirements: 11:14:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:14:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:26 INFO - u'jsshell-linux-x86_64.zip'], 11:14:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:14:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:14:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:14:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:14:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:14:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:26 INFO - https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/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 11:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/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 11:14:28 INFO - Downloaded 21943040 bytes. 11:14:28 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 11:14:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:28 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 11:14:29 INFO - Return code: 0 11:14:29 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 11:14: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')]} 11:14:29 INFO - https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/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 11:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/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 11:14:32 INFO - Downloaded 21943040 bytes. 11:14:32 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 11:14:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:32 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 11:14:33 INFO - Return code: 0 11:14: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')]} 11:14:33 INFO - https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:14:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/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 11:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/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 11:14:34 INFO - Downloaded 11132270 bytes. 11:14:34 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 11:14:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:34 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 11:14:34 INFO - Return code: 0 11:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:34 INFO - https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/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 11:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4KmR_j4RTyuQTyKquuxZ2w/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 11:14:36 INFO - Downloaded 53334021 bytes. 11:14:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:14:36 INFO - mkdir: /builds/slave/test/properties 11:14:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:14:36 INFO - Writing to file /builds/slave/test/properties/build_url 11:14:36 INFO - Contents: 11:14:36 INFO - build_url:https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:14:36 INFO - Running post-action listener: _resource_record_post_action 11:14:36 INFO - Running post-action listener: set_extra_try_arguments 11:14:36 INFO - ##### 11:14:36 INFO - ##### Running populate-webroot step. 11:14:36 INFO - ##### 11:14:36 INFO - Running pre-action listener: _resource_record_pre_action 11:14:36 INFO - Running main action method: populate_webroot 11:14:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:14:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:14:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:14:36 INFO - '--tppagecycles', 11:14:36 INFO - '7'], 11:14:36 INFO - 'tests': ['tsvgm']}}, 11:14:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:14:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:14:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:14:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:14:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:14:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:14:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:36 INFO - 'talos_options': ['--e10s'], 11:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:36 INFO - 'tests': ['damp', 'tps']}, 11:14:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:36 INFO - 'talos_options': ['--e10s'], 11:14:36 INFO - 'tests': ['damp', 'tps']}, 11:14:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:14:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:36 INFO - 'other': {'tests': ['a11yr', 11:14:36 INFO - 'ts_paint', 11:14:36 INFO - 'tpaint', 11:14:36 INFO - 'sessionrestore', 11:14:36 INFO - 'sessionrestore_no_auto_restore']}, 11:14:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:14:36 INFO - 'tests': ['a11yr', 11:14:36 INFO - 'ts_paint', 11:14:36 INFO - 'tpaint', 11:14:36 INFO - 'sessionrestore', 11:14:36 INFO - 'sessionrestore_no_auto_restore']}, 11:14:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:14:36 INFO - 'tests': ['a11yr', 11:14:36 INFO - 'ts_paint', 11:14:36 INFO - 'tpaint', 11:14:36 INFO - 'sessionrestore', 11:14:36 INFO - 'sessionrestore_no_auto_restore']}, 11:14:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:14:36 INFO - 'tests': ['a11yr', 11:14:36 INFO - 'ts_paint', 11:14:36 INFO - 'tpaint', 11:14:36 INFO - 'sessionrestore', 11:14:36 INFO - 'sessionrestore_no_auto_restore']}, 11:14:36 INFO - 'other_l64': {'tests': ['a11yr', 11:14:36 INFO - 'ts_paint', 11:14:36 INFO - 'tpaint', 11:14:36 INFO - 'sessionrestore', 11:14:36 INFO - 'sessionrestore_no_auto_restore']}, 11:14:36 INFO - 'other_nol64': {'tests': ['a11yr', 11:14:36 INFO - 'ts_paint', 11:14:36 INFO - 'tpaint', 11:14:36 INFO - 'sessionrestore', 11:14:36 INFO - 'sessionrestore_no_auto_restore']}, 11:14:36 INFO - 'svgr': {'tests': ['tsvgx', 11:14:36 INFO - 'tsvgr_opacity', 11:14:36 INFO - 'tart', 11:14:36 INFO - 'tscrollx', 11:14:36 INFO - 'cart']}, 11:14:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:14:36 INFO - 'tests': ['tsvgx', 11:14:36 INFO - 'tsvgr_opacity', 11:14:36 INFO - 'tart', 11:14:36 INFO - 'tscrollx', 11:14:36 INFO - 'cart']}, 11:14:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:36 INFO - 'tests': ['tp5o']}, 11:14:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:36 INFO - 'talos_options': ['--e10s'], 11:14:36 INFO - 'tests': ['tp5o']}, 11:14:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:36 INFO - 'talos_options': ['--xperf_path', 11:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:36 INFO - 'tests': ['tp5n']}, 11:14:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:36 INFO - 'talos_options': ['--e10s', 11:14:36 INFO - '--xperf_path', 11:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:36 INFO - 'tests': ['tp5n']}}, 11:14:36 INFO - 'talos.zip': {'path': '', 11:14:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:14:36 INFO - Running post-action listener: _resource_record_post_action 11:14:36 INFO - ##### 11:14:36 INFO - ##### Running create-virtualenv step. 11:14:36 INFO - ##### 11:14:36 INFO - Running pre-action listener: _resource_record_pre_action 11:14:36 INFO - Running main action method: create_virtualenv 11:14:36 INFO - Creating virtualenv /builds/slave/test/build/venv 11:14:36 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 11:14:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:14:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:37 INFO - Using real prefix '/usr' 11:14:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:14:37 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:39 INFO - Installing pip.................done. 11:14:39 INFO - Return code: 0 11:14:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:14:39 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')]} 11:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:39 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')]} 11:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:39 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 0x7fe65800bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', '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 11:14:39 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 11:14:39 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 11:14:39 INFO - Using env: {'DISPLAY': ':0', 11:14:39 INFO - 'HOME': '/home/cltbld', 11:14:39 INFO - 'LANG': 'en_US.UTF-8', 11:14:39 INFO - 'LANGUAGE': 'en_US:en', 11:14:39 INFO - 'LOGNAME': 'cltbld', 11:14:39 INFO - 'MAIL': '/var/mail/cltbld', 11:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:39 INFO - 'MOZ_NO_REMOTE': '1', 11:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:39 INFO - 'NO_EM_RESTART': '1', 11:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:39 INFO - 'PWD': '/builds/slave/test', 11:14:39 INFO - 'SHELL': '/bin/bash', 11:14:39 INFO - 'SHLVL': '1', 11:14:39 INFO - 'TERM': 'linux', 11:14:39 INFO - 'TMOUT': '86400', 11:14:39 INFO - 'USER': 'cltbld', 11:14:39 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:39 INFO - '_': '/tools/buildbot/bin/python'} 11:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:39 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 11:14:39 INFO - Cleaning up... 11:14:39 INFO - Return code: 0 11:14:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:14:39 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')]} 11:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:39 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')]} 11:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:39 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 0x7fe65800bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', '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 11:14:39 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 11:14:39 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 11:14:39 INFO - Using env: {'DISPLAY': ':0', 11:14:39 INFO - 'HOME': '/home/cltbld', 11:14:39 INFO - 'LANG': 'en_US.UTF-8', 11:14:39 INFO - 'LANGUAGE': 'en_US:en', 11:14:39 INFO - 'LOGNAME': 'cltbld', 11:14:39 INFO - 'MAIL': '/var/mail/cltbld', 11:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:39 INFO - 'MOZ_NO_REMOTE': '1', 11:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:39 INFO - 'NO_EM_RESTART': '1', 11:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:39 INFO - 'PWD': '/builds/slave/test', 11:14:39 INFO - 'SHELL': '/bin/bash', 11:14:39 INFO - 'SHLVL': '1', 11:14:39 INFO - 'TERM': 'linux', 11:14:39 INFO - 'TMOUT': '86400', 11:14:39 INFO - 'USER': 'cltbld', 11:14:39 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:39 INFO - '_': '/tools/buildbot/bin/python'} 11:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:39 INFO - Downloading/unpacking psutil>=0.7.1 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 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 11:14:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:14:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:41 INFO - Installing collected packages: psutil 11:14:41 INFO - Running setup.py install for psutil 11:14:41 INFO - building 'psutil._psutil_linux' extension 11:14:41 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 11:14:42 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 11:14:42 INFO - building 'psutil._psutil_posix' extension 11:14:42 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 11:14:42 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 11:14:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:42 INFO - Successfully installed psutil 11:14:42 INFO - Cleaning up... 11:14:42 INFO - Return code: 0 11:14:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:42 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 0x7fe65800bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', '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 11:14:42 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 11:14:42 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 11:14:42 INFO - Using env: {'DISPLAY': ':0', 11:14:42 INFO - 'HOME': '/home/cltbld', 11:14:42 INFO - 'LANG': 'en_US.UTF-8', 11:14:42 INFO - 'LANGUAGE': 'en_US:en', 11:14:42 INFO - 'LOGNAME': 'cltbld', 11:14:42 INFO - 'MAIL': '/var/mail/cltbld', 11:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:42 INFO - 'MOZ_NO_REMOTE': '1', 11:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:42 INFO - 'NO_EM_RESTART': '1', 11:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:42 INFO - 'PWD': '/builds/slave/test', 11:14:42 INFO - 'SHELL': '/bin/bash', 11:14:42 INFO - 'SHLVL': '1', 11:14:42 INFO - 'TERM': 'linux', 11:14:42 INFO - 'TMOUT': '86400', 11:14:42 INFO - 'USER': 'cltbld', 11:14:42 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:42 INFO - '_': '/tools/buildbot/bin/python'} 11:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:14:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:14:44 INFO - Installing collected packages: mozsystemmonitor 11:14:44 INFO - Running setup.py install for mozsystemmonitor 11:14:44 INFO - Successfully installed mozsystemmonitor 11:14:44 INFO - Cleaning up... 11:14:44 INFO - Return code: 0 11:14:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe65800bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', '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 11:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:14:44 INFO - Using env: {'DISPLAY': ':0', 11:14:44 INFO - 'HOME': '/home/cltbld', 11:14:44 INFO - 'LANG': 'en_US.UTF-8', 11:14:44 INFO - 'LANGUAGE': 'en_US:en', 11:14:44 INFO - 'LOGNAME': 'cltbld', 11:14:44 INFO - 'MAIL': '/var/mail/cltbld', 11:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:44 INFO - 'MOZ_NO_REMOTE': '1', 11:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:44 INFO - 'NO_EM_RESTART': '1', 11:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:44 INFO - 'PWD': '/builds/slave/test', 11:14:44 INFO - 'SHELL': '/bin/bash', 11:14:44 INFO - 'SHLVL': '1', 11:14:44 INFO - 'TERM': 'linux', 11:14:44 INFO - 'TMOUT': '86400', 11:14:44 INFO - 'USER': 'cltbld', 11:14:44 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:44 INFO - '_': '/tools/buildbot/bin/python'} 11:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:14:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:47 INFO - Downloading docopt-0.6.1.tar.gz 11:14:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:47 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:47 INFO - Running setup.py install for blobuploader 11:14:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:14:47 INFO - Running setup.py install for requests 11:14:47 INFO - Running setup.py install for docopt 11:14:47 INFO - Successfully installed blobuploader requests docopt 11:14:47 INFO - Cleaning up... 11:14:47 INFO - Return code: 0 11:14:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:47 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')]} 11:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:47 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')]} 11:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:47 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 0x7fe65800bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', '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 11:14:47 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 11:14:47 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 11:14:47 INFO - Using env: {'DISPLAY': ':0', 11:14:47 INFO - 'HOME': '/home/cltbld', 11:14:47 INFO - 'LANG': 'en_US.UTF-8', 11:14:47 INFO - 'LANGUAGE': 'en_US:en', 11:14:47 INFO - 'LOGNAME': 'cltbld', 11:14:47 INFO - 'MAIL': '/var/mail/cltbld', 11:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:47 INFO - 'MOZ_NO_REMOTE': '1', 11:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:47 INFO - 'NO_EM_RESTART': '1', 11:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:47 INFO - 'PWD': '/builds/slave/test', 11:14:47 INFO - 'SHELL': '/bin/bash', 11:14:47 INFO - 'SHLVL': '1', 11:14:47 INFO - 'TERM': 'linux', 11:14:47 INFO - 'TMOUT': '86400', 11:14:47 INFO - 'USER': 'cltbld', 11:14:47 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:47 INFO - '_': '/tools/buildbot/bin/python'} 11:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:47 INFO - Running setup.py (path:/tmp/pip-pSrFF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:47 INFO - Running setup.py (path:/tmp/pip-fPlmvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:48 INFO - Running setup.py (path:/tmp/pip-iTTIlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:48 INFO - Running setup.py (path:/tmp/pip-M_dHeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:48 INFO - Running setup.py (path:/tmp/pip-njKRMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:48 INFO - Running setup.py (path:/tmp/pip-794oLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:48 INFO - Running setup.py (path:/tmp/pip-8nNclb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:48 INFO - Running setup.py (path:/tmp/pip-tJbWJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:48 INFO - Running setup.py (path:/tmp/pip-n6YbO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:48 INFO - Running setup.py (path:/tmp/pip-tLUySf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:48 INFO - Running setup.py (path:/tmp/pip-0RE08r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:48 INFO - Running setup.py (path:/tmp/pip-LhoJVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:48 INFO - Running setup.py (path:/tmp/pip-YK5oM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:48 INFO - Running setup.py (path:/tmp/pip-TcqT3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:48 INFO - Running setup.py (path:/tmp/pip-gLEkUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:48 INFO - Running setup.py (path:/tmp/pip-7lln4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:49 INFO - Running setup.py (path:/tmp/pip-pcaLjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:49 INFO - Running setup.py install for manifestparser 11:14:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:14:49 INFO - Running setup.py install for mozcrash 11:14:49 INFO - Running setup.py install for mozdebug 11:14:49 INFO - Running setup.py install for mozdevice 11:14:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:14:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:49 INFO - Running setup.py install for mozfile 11:14:49 INFO - Running setup.py install for mozhttpd 11:14:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:49 INFO - Running setup.py install for mozinfo 11:14:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:49 INFO - Running setup.py install for mozInstall 11:14:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:49 INFO - Running setup.py install for mozleak 11:14:50 INFO - Running setup.py install for mozlog 11:14:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:14:50 INFO - Running setup.py install for moznetwork 11:14:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:14:50 INFO - Running setup.py install for mozprocess 11:14:50 INFO - Running setup.py install for mozprofile 11:14:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:14:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:14:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:14:50 INFO - Running setup.py install for mozrunner 11:14:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:14:50 INFO - Running setup.py install for mozscreenshot 11:14:50 INFO - Running setup.py install for moztest 11:14:50 INFO - Running setup.py install for mozversion 11:14:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:14:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:50 INFO - Cleaning up... 11:14:50 INFO - Return code: 0 11:14:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:50 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 0x7fe65800bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', '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 11:14:50 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 11:14:50 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 11:14:50 INFO - Using env: {'DISPLAY': ':0', 11:14:50 INFO - 'HOME': '/home/cltbld', 11:14:50 INFO - 'LANG': 'en_US.UTF-8', 11:14:50 INFO - 'LANGUAGE': 'en_US:en', 11:14:50 INFO - 'LOGNAME': 'cltbld', 11:14:50 INFO - 'MAIL': '/var/mail/cltbld', 11:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:50 INFO - 'MOZ_NO_REMOTE': '1', 11:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:50 INFO - 'NO_EM_RESTART': '1', 11:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:50 INFO - 'PWD': '/builds/slave/test', 11:14:50 INFO - 'SHELL': '/bin/bash', 11:14:50 INFO - 'SHLVL': '1', 11:14:50 INFO - 'TERM': 'linux', 11:14:50 INFO - 'TMOUT': '86400', 11:14:50 INFO - 'USER': 'cltbld', 11:14:50 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:50 INFO - '_': '/tools/buildbot/bin/python'} 11:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:51 INFO - Running setup.py (path:/tmp/pip-4b4E14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:51 INFO - Running setup.py (path:/tmp/pip-pPGdoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:51 INFO - Running setup.py (path:/tmp/pip-TUPS5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:51 INFO - Running setup.py (path:/tmp/pip-PffLDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:51 INFO - Running setup.py (path:/tmp/pip-4GSEiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:51 INFO - Running setup.py (path:/tmp/pip-hYqvbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:51 INFO - Running setup.py (path:/tmp/pip-cCDJ46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:51 INFO - Running setup.py (path:/tmp/pip-RN7L92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:51 INFO - Running setup.py (path:/tmp/pip-buvDeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:51 INFO - Running setup.py (path:/tmp/pip-G_h0ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:51 INFO - Running setup.py (path:/tmp/pip-pXz4jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:51 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)) 11:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:51 INFO - Running setup.py (path:/tmp/pip-WV1cJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:52 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)) 11:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:52 INFO - Running setup.py (path:/tmp/pip-zZUeH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:52 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)) 11:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:52 INFO - Running setup.py (path:/tmp/pip-0wPkHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:52 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)) 11:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:52 INFO - Running setup.py (path:/tmp/pip-rODB4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:52 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)) 11:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:52 INFO - Running setup.py (path:/tmp/pip-I7gAbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:52 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)) 11:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:52 INFO - Running setup.py (path:/tmp/pip-XKteTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:52 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)) 11:14:52 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)) 11:14:52 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)) 11:14:52 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)) 11:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:52 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 11:14:52 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 11:14:52 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 11:14:52 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 11:14:52 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 11:14:52 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 11:14:54 INFO - Downloading blessings-1.5.1.tar.gz 11:14:54 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 11:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:54 INFO - Installing collected packages: blessings 11:14:54 INFO - Running setup.py install for blessings 11:14:54 INFO - Successfully installed blessings 11:14:54 INFO - Cleaning up... 11:14:54 INFO - Return code: 0 11:14:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:54 INFO - Reading from file tmpfile_stdout 11:14:54 INFO - Current package versions: 11:14:54 INFO - argparse == 1.2.1 11:14:54 INFO - blessings == 1.5.1 11:14:54 INFO - blobuploader == 1.2.4 11:14:54 INFO - docopt == 0.6.1 11:14:54 INFO - manifestparser == 1.1 11:14:54 INFO - mozInstall == 1.12 11:14:54 INFO - mozcrash == 0.16 11:14:54 INFO - mozdebug == 0.1 11:14:54 INFO - mozdevice == 0.47 11:14:54 INFO - mozfile == 1.2 11:14:54 INFO - mozhttpd == 0.7 11:14:54 INFO - mozinfo == 0.9 11:14:54 INFO - mozleak == 0.1 11:14:54 INFO - mozlog == 3.1 11:14:54 INFO - moznetwork == 0.27 11:14:54 INFO - mozprocess == 0.22 11:14:54 INFO - mozprofile == 0.28 11:14:54 INFO - mozrunner == 6.11 11:14:54 INFO - mozscreenshot == 0.1 11:14:54 INFO - mozsystemmonitor == 0.0 11:14:54 INFO - moztest == 0.7 11:14:54 INFO - mozversion == 1.4 11:14:54 INFO - psutil == 3.1.1 11:14:54 INFO - requests == 1.2.3 11:14:54 INFO - wsgiref == 0.1.2 11:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe65800bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', '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 11:14:54 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 11:14:54 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 11:14:54 INFO - Using env: {'DISPLAY': ':0', 11:14:54 INFO - 'HOME': '/home/cltbld', 11:14:54 INFO - 'LANG': 'en_US.UTF-8', 11:14:54 INFO - 'LANGUAGE': 'en_US:en', 11:14:54 INFO - 'LOGNAME': 'cltbld', 11:14:54 INFO - 'MAIL': '/var/mail/cltbld', 11:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:54 INFO - 'MOZ_NO_REMOTE': '1', 11:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:54 INFO - 'NO_EM_RESTART': '1', 11:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:54 INFO - 'PWD': '/builds/slave/test', 11:14:54 INFO - 'SHELL': '/bin/bash', 11:14:54 INFO - 'SHLVL': '1', 11:14:54 INFO - 'TERM': 'linux', 11:14:54 INFO - 'TMOUT': '86400', 11:14:54 INFO - 'USER': 'cltbld', 11:14:54 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:54 INFO - '_': '/tools/buildbot/bin/python'} 11:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:54 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)) 11:14:54 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)) 11:14:54 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)) 11:14:54 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)) 11:14:54 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)) 11:14:54 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)) 11:14:54 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)) 11:14:54 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)) 11:14:54 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)) 11:14:54 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)) 11:14:54 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)) 11:14:54 INFO - Cleaning up... 11:14:54 INFO - Return code: 0 11:14:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65800bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', '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 11:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:14:54 INFO - Using env: {'DISPLAY': ':0', 11:14:54 INFO - 'HOME': '/home/cltbld', 11:14:54 INFO - 'LANG': 'en_US.UTF-8', 11:14:54 INFO - 'LANGUAGE': 'en_US:en', 11:14:54 INFO - 'LOGNAME': 'cltbld', 11:14:54 INFO - 'MAIL': '/var/mail/cltbld', 11:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:54 INFO - 'MOZ_NO_REMOTE': '1', 11:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:54 INFO - 'NO_EM_RESTART': '1', 11:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:54 INFO - 'PWD': '/builds/slave/test', 11:14:54 INFO - 'SHELL': '/bin/bash', 11:14:54 INFO - 'SHLVL': '1', 11:14:54 INFO - 'TERM': 'linux', 11:14:54 INFO - 'TMOUT': '86400', 11:14:54 INFO - 'USER': 'cltbld', 11:14:54 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:54 INFO - '_': '/tools/buildbot/bin/python'} 11:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:54 INFO - Downloading/unpacking jsonschema 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:56 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 11:14:56 INFO - Downloading/unpacking functools32 (from jsonschema) 11:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:56 INFO - warning: no files found matching '*.txt' 11:14:56 INFO - no previously-included directories found matching 'build' 11:14:56 INFO - no previously-included directories found matching 'dist' 11:14:56 INFO - no previously-included directories found matching '.git*' 11:14:56 INFO - Installing collected packages: jsonschema, functools32 11:14:56 INFO - Running setup.py install for functools32 11:14:57 INFO - warning: no files found matching '*.txt' 11:14:57 INFO - no previously-included directories found matching 'build' 11:14:57 INFO - no previously-included directories found matching 'dist' 11:14:57 INFO - no previously-included directories found matching '.git*' 11:14:57 INFO - Successfully installed jsonschema functools32 11:14:57 INFO - Cleaning up... 11:14:57 INFO - Return code: 0 11:14:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:14:57 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')]} 11:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:57 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')]} 11:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:57 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 0x7fe65800bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', '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 11:14:57 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 11:14:57 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 11:14:57 INFO - Using env: {'DISPLAY': ':0', 11:14:57 INFO - 'HOME': '/home/cltbld', 11:14:57 INFO - 'LANG': 'en_US.UTF-8', 11:14:57 INFO - 'LANGUAGE': 'en_US:en', 11:14:57 INFO - 'LOGNAME': 'cltbld', 11:14:57 INFO - 'MAIL': '/var/mail/cltbld', 11:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:57 INFO - 'MOZ_NO_REMOTE': '1', 11:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:57 INFO - 'NO_EM_RESTART': '1', 11:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:57 INFO - 'PWD': '/builds/slave/test', 11:14:57 INFO - 'SHELL': '/bin/bash', 11:14:57 INFO - 'SHLVL': '1', 11:14:57 INFO - 'TERM': 'linux', 11:14:57 INFO - 'TMOUT': '86400', 11:14:57 INFO - 'USER': 'cltbld', 11:14:57 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:57 INFO - '_': '/tools/buildbot/bin/python'} 11:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:57 INFO - Downloading/unpacking flake8 11:14:57 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 11:14:57 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 11:14:57 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 11:14:57 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 11:14:57 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 11:14:57 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 11:14:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:14:58 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 11:14:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:14:59 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 11:14:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:14:59 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 11:14:59 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 11:14:59 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 11:14:59 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 11:14:59 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 11:14:59 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 11:14:59 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 11:14:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:14:59 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 11:14:59 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 11:14:59 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 11:14:59 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 11:14:59 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 11:14:59 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 11:14:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:14:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:59 INFO - no previously-included directories found matching 'docs/_build' 11:14:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:14:59 INFO - Running setup.py install for pep8 11:14:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:59 INFO - no previously-included directories found matching 'docs/_build' 11:14:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:14:59 INFO - Cleaning up... 11:14:59 INFO - Return code: 0 11:14:59 INFO - Running post-action listener: _resource_record_post_action 11:14:59 INFO - Running post-action listener: _start_resource_monitoring 11:14:59 INFO - Starting resource monitoring. 11:14:59 INFO - ##### 11:14:59 INFO - ##### Running install step. 11:14:59 INFO - ##### 11:14:59 INFO - Running pre-action listener: _resource_record_pre_action 11:14:59 INFO - Running main action method: install 11:14:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:00 INFO - Reading from file tmpfile_stdout 11:15:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:15:00 INFO - Reading from file tmpfile_stdout 11:15:00 INFO - Output received: 11:15:00 INFO - Usage: mozinstall [options] installer 11:15:00 INFO - Options: 11:15:00 INFO - -h, --help show this help message and exit 11:15:00 INFO - -d DEST, --destination=DEST 11:15:00 INFO - Directory to install application into. [default: 11:15:00 INFO - "/builds/slave/test"] 11:15:00 INFO - --app=APP Application being installed. [default: firefox] 11:15:00 INFO - mkdir: /builds/slave/test/build/application 11:15:00 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'] 11:15:00 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 11:15:16 INFO - Reading from file tmpfile_stdout 11:15:16 INFO - Output received: 11:15:16 INFO - /builds/slave/test/build/application/firefox/firefox 11:15:16 INFO - Running post-action listener: _resource_record_post_action 11:15:16 INFO - ##### 11:15:16 INFO - ##### Running run-tests step. 11:15:16 INFO - ##### 11:15:16 INFO - Running pre-action listener: _resource_record_pre_action 11:15:16 INFO - Running main action method: run_tests 11:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:15:16 INFO - Python 2.7.3 11:15:16 INFO - Return code: 0 11:15:16 INFO - grabbing minidump binary from tooltool 11:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:16 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 0x128b3d0>, '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 0x11f6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f7360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:15:16 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 11:15:16 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 11:15:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:16 INFO - Return code: 0 11:15:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:15:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:15:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:15:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:15:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:15:17 INFO - Return code: 0 11:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:15:17 INFO - Using env: {'DISPLAY': ':0', 11:15:17 INFO - 'HOME': '/home/cltbld', 11:15:17 INFO - 'LANG': 'en_US.UTF-8', 11:15:17 INFO - 'LANGUAGE': 'en_US:en', 11:15:17 INFO - 'LOGNAME': 'cltbld', 11:15:17 INFO - 'MAIL': '/var/mail/cltbld', 11:15:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:17 INFO - 'MOZ_NO_REMOTE': '1', 11:15:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:17 INFO - 'NO_EM_RESTART': '1', 11:15:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:17 INFO - 'PWD': '/builds/slave/test', 11:15:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:17 INFO - 'SHELL': '/bin/bash', 11:15:17 INFO - 'SHLVL': '1', 11:15:17 INFO - 'TERM': 'linux', 11:15:17 INFO - 'TMOUT': '86400', 11:15:17 INFO - 'USER': 'cltbld', 11:15:17 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247', 11:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:17 INFO - '_': '/tools/buildbot/bin/python'} 11:15:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:15:17 INFO - mozversion application_buildid: 20151229103437 11:15:17 INFO - mozversion application_changeset: 4ad0371b1a072e4153972e4cc76dc773b1e001b9 11:15:17 INFO - mozversion application_display_name: Nightly 11:15:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:17 INFO - mozversion application_name: Firefox 11:15:17 INFO - mozversion application_remotingname: firefox 11:15:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 11:15:17 INFO - mozversion application_vendor: Mozilla 11:15:17 INFO - mozversion application_version: 46.0a1 11:15:17 INFO - mozversion platform_buildid: 20151229103437 11:15:17 INFO - mozversion platform_changeset: 4ad0371b1a072e4153972e4cc76dc773b1e001b9 11:15:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 11:15:17 INFO - mozversion platform_version: 46.0a1 11:15:17 INFO - using testdate: 1451416517 11:15:17 INFO - actual date: 1451416517 11:15:17 INFO - starting webserver on 'localhost:46865' 11:15:17 INFO - SUITE-START | Running 3 tests 11:15:17 INFO - TEST-START | dromaeo_css 11:15:17 INFO - operating with platform_type : linux_ 11:15:17 INFO - Initialising browser for dromaeo_css test... 11:15:17 INFO - TEST-INFO | started process 27975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfHHaQL/profile http://localhost:46865/getInfo.html) 11:15:22 INFO - PROCESS | 27975 | __metrics Screen width/height:1600/1200 11:15:22 INFO - PROCESS | 27975 | colorDepth:24 11:15:22 INFO - PROCESS | 27975 | Browser inner width/height: 1024/697 11:15:22 INFO - PROCESS | 27975 | __metrics 11:15:22 INFO - PROCESS | 27975 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:15:22 INFO - PROCESS | 27975 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:15:23 INFO - TEST-INFO | 27975: exit 0 11:15:23 INFO - Browser initialized. 11:15:23 INFO - Running cycle 1/1 for dromaeo_css test... 11:15:23 INFO - TEST-INFO | started process 28070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfHHaQL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:35 INFO - PROCESS | 28070 | RSS: Main: 148996096 11:15:35 INFO - PROCESS | 28070 | 11:16:27 INFO - PROCESS | 28070 | 1451416587012 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] 11:18:39 INFO - PROCESS | 28070 | Cycle 1(1): loaded http://localhost:46865/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46865/tests/dromaeo/cssquery-ext.html) 11:18:40 INFO - PROCESS | 28070 | RSS: Main: 252616704 11:18:40 INFO - PROCESS | 28070 | 11:21:42 INFO - PROCESS | 28070 | Cycle 1(1): loaded http://localhost:46865/tests/dromaeo/cssquery-ext.html (next: http://localhost:46865/tests/dromaeo/cssquery-jquery.html) 11:21:43 INFO - PROCESS | 28070 | RSS: Main: 233385984 11:21:43 INFO - PROCESS | 28070 | 11:24:45 INFO - PROCESS | 28070 | Cycle 1(1): loaded http://localhost:46865/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46865/tests/dromaeo/cssquery-mootools.html) 11:24:46 INFO - PROCESS | 28070 | RSS: Main: 224100352 11:24:46 INFO - PROCESS | 28070 | 11:27:48 INFO - PROCESS | 28070 | Cycle 1(1): loaded http://localhost:46865/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46865/tests/dromaeo/cssquery-prototype.html) 11:27:48 INFO - PROCESS | 28070 | RSS: Main: 210804736 11:27:48 INFO - PROCESS | 28070 | 11:30:51 INFO - PROCESS | 28070 | Cycle 1(1): loaded http://localhost:46865/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46865/tests/dromaeo/cssquery-yui.html) 11:30:52 INFO - PROCESS | 28070 | RSS: Main: 194158592 11:30:52 INFO - PROCESS | 28070 | 11:33:54 INFO - PROCESS | 28070 | Cycle 1(1): loaded http://localhost:46865/tests/dromaeo/cssquery-yui.html (next: http://localhost:46865/tests/dromaeo/cssquery-dojo.html) 11:33:54 INFO - PROCESS | 28070 | RSS: Main: 261967872 11:33:54 INFO - PROCESS | 28070 | 11:33:54 INFO - PROCESS | 28070 | __start_tp_report 11:33:54 INFO - PROCESS | 28070 | _x_x_mozilla_page_load 11:33:54 INFO - PROCESS | 28070 | _x_x_mozilla_page_load_details 11:33:54 INFO - PROCESS | 28070 | |i|pagename|runs| 11:33:54 INFO - PROCESS | 28070 | |0;dojo.html;2618.4370360372523;2720.0207925146956;2721.0748345562506;2735.4802587508384;2737.247257004324;4525.343825145352;4647;4694.507076756939;4699.2011358069085;4699.7415142167165;4602.516735742741;4659.883502912429;4670.2527595584625;4672.415948006499;4685.508021657728;4286.699931004831;4352.368906508555;4367.650587952964;4470.083632855257;4478.440194975628;4184.225918205127;4388.144311859189;4423.203823311803;4475.283954567253;4509.864704058883;4216.852410165629;4291.227579035773;4298;4322.891927701832;4334.761588112652;4331.7184383015;4351.28203846365;4360.563943605645;4395.604395604411;4404.0531285773395;4181.372794080912;4338.284183109783;4352.608265256111;4353.194658988097;4399.494058183318;4607.953920460786;4608.8386906458445;4615.699979501322;4638.582527572535;4641.164590373732;4944;5007.298978143063;5083.771230294646;5095.363079615048;5145.742712864379;5045.117104506697;5046.545810877039;5049.3183420238165;5057.165567681328;5115.667481613683;4513.864584062483;4621.560951709582;4677.298405239173;4677.7661116944355;4685.4143232095985;5038.496150384932;5139.177731562932;5218.399884013387;5258.07983602868;5264.210368444764;4939.209726443752;4957.529034741694;4961.305417241589;4962.230854217602;5000.024995125916;4850.1997170466475;4921.606271498272;5045.84862454127;5052.949470505321;5063.11395505785;4841.346418233564;4879.048585525859;4988.052270068675;4993.700377977333;5011.323471331397;4912.336834527293;4917.606591472673;4924.9507504925205;4929;4969.801207951714;4085.632293093636;4181.059261666101;4216.388623649554;4219.578042195756;4268.978655106766;3652.3060618482405;3653.0319465341177;3708.9072773180346;3710.5176327077306;3739.794311312904;4301.698881078294;4320.351947207944;4322.222000040023;4328.653707703439;4365.236083685342;4848;4964.751762411865;5045.520675535819;5069.518395752398;5135.486451354835;4220.894477638084;4231.217224813419;4286.142771445661;4298;4323.2434323993175;4533.659975501851;4560.4071470708595;4568.543145685405;4573.748443835621;4574.108048930493;4553.9089218214785;4670.322803193586;4793.544613261734;4806.735629540339;4812.951870481251;4925.507449255046;5028.874278143076;5083.38999320084;5107.284980102714;5150.48495150482;4812.927806082842;4824.6863953842885;4827;4829.13075646387;4873.805047798191;4759.571638552547;4868.002059577707;4997.925031124463;5002.299678045004;5047.949520504748;4924.729139897197;5039.546440820343;5109.69341839476;5128.512791284822;5140.203268493389;4820.662553621353;4870.537298956593;4872.878178045577;4882.82910098159;4922.335484709519;4714.882127946828;4820.542048505386;4835.58897493717;4844.612431005582;4881.829135980223;4672.696274742131;4746.335513028248;4843.491433399583;4857.514248575114;4882.048000639983;4928.457869634409;4946.060248552763;4948.529889660476;4955.083309587738;4970.62720295972;4656.068786242833;4835.540623640749;4836.830710925101;4849.466558678472;4864.270359446112 11:33:54 INFO - PROCESS | 28070 | |1;ext.html;471.4389876047503;490.0468588595182;504.60892808073737;511.797839853258;546.3716725765366;25017.74840264376;25541.233762987118;32437.189070273227;33001.66998330016;33056.17359566006;35882.10294742633;36413.63586364136;36469;36471.635283647156;36540.63459365405;6875.828104297382;7526.849463010736;7678.654460549289;7681.039870016248;7683.385329173652;6999.335063168991;9516.666916657918;9703.126718595326;9708.417494950325;9709.465979371133;9388.62445502179;9496.430214187136;9503.90496095037;9505.762355941088;9510.239180865548;7077.646117694095;7189.2810718927685;9458.148766611039;9466.66866659667;9569.952150239274;9207.217386522087;9280.90719092814;9289.303302252358;9290.674826381044;9292.210162136227;32266.193345166324;32930.835345823354;32948;32983.83508082468;33048.50427243593;2655.150351887397;2687.6102965069954;2715.321169707573;3349.5478110455265;3425.3491836550975;26283.08009219668;27386.589201161798;28129;28433.147005589864;28875.566866497018;3329.0845017620104;3471.1495683557437;3475.6524347565296;3489.8255087245534;3602.0274525877867;211695.59652841603;213370;214264;215422.92288538613;216040;47639.28541071887;48464;53977.46022539803;56023.159652605245;56060.43939560552;47057;47631.28553071707;47819.76090119527;47882.28176577354;47974.76012619984;12260.75478490443;12403.193792403465;12403.875961240452;12553.874461255271;12558.246505209716;9205;9376.812463750823;9392.906070939203;9411.623535058521;9532.475713835667;18294.908525457555;18324.358647447276;19063.237470501303;19110.140043698066;19130.426087217405;6229.906551401733;6231.875362492725;6239;6302.842428939313;6323.810285691437;787.3897729259869;796.9163237860057;829.8340331933638;833.2126140796888;849.4775712936499;23233.535329293318;23498.882505587364;23676.64485032726;23684;23693.881530592236;937.1097457415483;943.4009404028354;943.5753910740194;956.2636769687302;1057.8466122412208;12630.483271375464;12953.54662586805;13048.151870128411;13053.804192937114;13064.150830196008;326845;331192;332488;332550;334565;39877.80061099676;39907.20185596272;40375.798121009204;41560.79219603883;42412.363814542805;1146.2721172055637;1176.4353110507004;1186.128195776104;1186.95845645402;1196.0909708621336;22427.66358504591;22751.203707870147;22996.655050174595;23119.190828320927;23223.0710771574;30042.399152017275;36151.81924090363;36760.26479470449;40384.79807601061;41445.40487034332;159955;162494;162722;163145;164690.1765491165;27396.863015684794;27838.721612784422;27860.442791143658;27908.30229244285;27915.720842792125;35768.64231357653;36025.0993725159;36609.45085823768;36810.8159459201;36900.446493303156;32891;32982.50526242156;33411.83294083611;33922.49116263209;34226.48660270148;31816.045518634477;32305.35389292248;32481.35037299288;32854.83572582122;32894.67105328916;32811.539134564526;33469.497957531144;33587.32825343431;33980;34019.31961360709;29396.265093372836;30378.39243215079;30968.53547196839;30993.8450307747;31009.844950775103;23648.881755591112;23742.881285593463;23768.64347034761;24065;24158.87920560386 11:33:54 INFO - PROCESS | 28070 | |2;jquery.html;334.6887394722908;334.7924286942096;336.3844165177724;336.3877742508635;340.9982950085249;12407.627771166857;12805.679858003554;13880.6529836754;14258.287085645716;14510.492132775342;12706.17409868358;14594.927025364857;14818.777718334233;14888;14900.776488352683;4735.076660051292;4738.431388233417;4854.732989685566;4867.68360056597;4870;3661.7986010769396;3770.0386401467586;4974.552290293873;5022.447530771612;5608.887822243552;5690.231818704484;5708.343540492855;5744.195812586241;5749.080147176453;5750.913736293959;5531.944680553203;5696.487316141525;5708.91436628453;5715.257016587838;5725.227094342252;5032.597392208614;5038.697678139287;5047.570956468705;5048.14181589127;5049.570786483153;18525.16636751336;18894.905525472423;19117;19123.23507059716;19478.318258860872;1425.9572212833632;1594.5455545169687;1722.715751900935;1770.9380171693929;1820.4629634257794;8069.354451643854;8080.636371363303;8111.310538604226;8426.157384261585;10656.04095631397;1634.4933070748107;1683.3823404605832;1689.374931275436;1706.6501367219814;1718.7023797033285;52078.21882671725;53680.73159634216;54031.18953215705;56552.43447565513;58054.41945580574;9148.359614826899;9504.524773761423;9746.707598772047;9775.266854985905;9810.80378392428;12547.435365408579;12555.811662825065;12575.874241257654;12586;12588.559400420942;6581.638009909501;6685.164354455693;6719.160104986877;6803;6837.726490940406;6374.043893415932;6387.23747497982;6452.483801295885;6546.378094081055;6566.179227596551;3834.539855217336;3838.2707285615643;3905.9804700976883;3907.081835768592;4012.6388625023305;1481.8666320031034;1603.2144249317982;1672.715638341485;1683.8867221637013;1713.366054559821;357.64235764235764;357.6959584353279;373.1250218238227;772.7063715787965;838.421489172469;9100.8634870477;9107.908920910839;9293.488858112734;9449.763755906157;9467.952660236793;362.82765686298796;362.9110867837344;371.6655010490526;375.2907005759117;393.7381641208564;5041.193409054534;5203.297554830049;8601.268892144239;9252.583633736498;9310.487923164292;332114;333789;336462;341752;567939;63200.683996579726;70141.64929175322;73861;74767.62616186884;77507.22492775;992.4442312304988;1007.3804610164696;1029.2280789408094;1030.386919782743;1032.5869652139204;13396.196228226338;14253.714925701635;14257.144571325338;14321;14674.77987830162;26498.867505662347;28817;30349.241268968453;31999.68000319967;32068.67931320657;39232;40592;40905.181896362505;41130;42332;8540.701075462577;8598.570071496526;8748.868766968373;8765;8778.429402088845;10167.949160254151;10985;16381.344746210018;16406.753898691768;16434;13031.283279419724;13797.448102075805;13814;14050.156990580597;14427.062240954305;13491.190528568317;13806.792898106738;13901.304934753423;13964.162150271017;14273.286335683382;13581.185128892299;13895.58313250604;14000.43998240059;14123.858761412253;14504.202268875313;7080.468964827762;7299.6350182489605;8183.140770219279;8565.100664430145;8731.607077681392;8385.53879536607;8494.023187333536;10375.740606484898;13230.272335021282;13358.933205333911 11:33:54 INFO - PROCESS | 28070 | |3;mootools.html;1094.485591771868;1310.5478609879592;1333.6199183232777;1396.5112210726247;1732.4629364896882;5771.769129234831;6560;6593.736250549984;6637.834054148649;6657.600543967365;6523.532205253816;6645.969874669434;6657.167854018247;6696.397324240817;6721.126253587039;2013.506690860734;2028.7971202879667;2048.6312463756517;2050.8666936649147;2053.9589208215825;2090.4042347930845;2091.4144039668918;2101.8003289687454;2141;2146.431195733132;2062.8040336168115;2070.9378718638463;2094.036743098177;2097.3393381084984;2097.402240361497;2046.94882627934;2067.472794437409;2070.171931227506;2070.87574745515;2071.8756874587575;2069.896505174735;2079.6360636888635;2114.619368513667;2116.4603026228215;2117.5658989907033;7091.255418181068;7158.355747982707;7167.354938055548;7174.174969878479;7176.7488137914925;4161.2301724181125;4214.536400995888;4228.238916994939;4233.724807887477;4253.893652658678;2703.1620197738566;2706.742859428351;2727.7135900730536;2729.767969722576;2772.334639686481;885.4952676974063;889.0842432294746;899.7255836969722;919.0579655852738;943.3585162089777;9704.805903881954;9706;9733.124018838338;9736.172425343855;9743.171830394425;3837.2901013312626;3860.9227815443533;3917.05990562263;3941.38908469182;3946.6053394660303;7985.081715602664;7998.880016799752;8007.279344858991;8014.15851335613;8018.077921039155;4318.719283246579;4335.501417337046;4341.60925516705;4341.9131617367475;4345.891352716144;3213.4215841148352;3305.2397948471985;3656.8171591420323;3934.055826601595;3960.7029472789654;3269.54226408303;3339.899803005914;3362.3779600773937;3372.51098590703;3386.593608766964;1099.7855418193376;1112.1158678850334;1114.1977776001265;1115.4367044642404;1125.4935279124427;1109.1681239070697;1134.6142311614092;1135.3982389333667;1147.512307269407;1154.2382027861572;6536.444402225769;6607.405333520006;6658.3674550917585;6667.86664266712;6684.097646817618;404.7450106432987;416.61046921128843;421.4521122540685;424.31684987171246;425.8743670617175;5258.0009798138235;5315.840524784263;5328.094223981932;5335.626506144533;5340.626156169109;8331.8333633327;8354.081051084377;8467.195616416431;8494.428530721712;8639.265662418766;8418.158184181655;8515.19105684959;8528.445651032787;8529.232369086812;8530.232279094911;6575.178102737158;6645.1361323027695;6670.633115178614;6777.661116944133;6798.490113241527;6341;6347.841303967253;6378.45783108441;6380.202474690664;6387.584806987531;7556.433267504849;7584.393248540214;7815.570143642154;7818.061832580127;7868.72459463916;7741.1871753465075;7832.647530861011;7899.644515996679;7912.0901096374655;7962.482438641469;5104.285400043923;5198.792048318025;6092.603980741238;6167.414095660905;6188.1027251049245;6314.842128946813;6352.36476352361;6395.136656551306;6397.840053998687;6404.93595064062;6070.939290607037;6084.148219249397;6169.167162433194;6255.155554000152;6282.1519094921605;6090.23872015998;6120.387961203844;6148.231471066117;6155.692215389302;6267.717952692231;6071.180390647206;6121.816345509642;6133.417325354084;6192.442680158807;6226.782062627786;5523.696196709059;5531.917021244604;5549.611527193058;5559.972200138974;5567.944320556742;5777.508911742549;5828.854278643068;5860.765569377178;5868.38381969887;5877.118432235199 11:33:54 INFO - PROCESS | 28070 | |4;prototype.html;296.17515220111966;303.7478892519208;304.6450884719302;311.1102247571944;312.302005018783;5370.731463426832;5393.1910213468;5406.945930540694;5421.1326187809955;5446.645968012086;5322.600804939626;5331.386890507592;5334.67991920485;5342.0651386007485;5345.49217824307;3916.9815847879613;4100.815463304143;4111.09555897702;4148.398482220076;4151.709380343377;3998.5601583825755;4087.9591204087874;4155.231282212785;4163.02168990287;4168.729032612886;4106.32245679464;4115.36211887158;4117.794110294488;4121.381792731099;4162.500499939996;3886.9028274293087;3941.1920556286177;4024.5170579530645;4159.209750147463;4163.91672166555;3613.421852503613;3623.58328792187;3637.672609465161;3647.2340808430263;3669.321175582526;5104.64267501275;5141.511556402136;5149.124648809711;5155.5617772489;5175.378954525443;4743.715377077387;4749.57253847152;4769.427668679746;4771.403574553181;4775.164346239394;5444;5601.075822489284;5609.831705048855;5619.072852979253;5626.549876009909;4010.5588385277597;4011.3581826907553;4013.2776100301935;4014.096828213658;4016.477857878457;5905.350411454737;5906.350301466835;5907.700305932731;5909.320428150775;5918.733656985446;4133.23535145999;4142.482189726285;4148.896277593084;4150.439690641725;4154.543000269968;3947.210557888434;4086.8773936781945;4173.040200753843;4202.894927626834;4208.579142085767;4656.511066338054;4667.8599642010795;4673.088747694167;4707.411573553306;4708.246680531167;5635.774569017275;5641.26663533738;5647.548196144298;5648.039833228361;5655.632383895034;1423.3168079321983;1445.966134214042;1446.4792674637122;1446.4864972934668;1446.5443385333585;943.1605870775015;959.8464245720651;976.1800087926176;978.3054031637618;981.9410835349759;4875.780589873464;4887.73117478535;4902;4902.730349830722;4905.264210368473;5851.093080572518;5853.180554722342;5855.707214639251;5860.941390586039;5861.443162899518;4897.069556784271;4897.265410188429;4902.803887844446;4904.068227036852;4906.484819094015;3071.385722855393;3118.251619611277;3143.5913331267247;3148.874045038219;3156.0847354267466;5540.612157149041;5545.251391062155;5551.916721249185;5589.301337332833;5613.635113717595;6047.12316714074;6055.7274922628585;6060.939390606126;6067.908981365283;6096.481799047042;5615.18579805934;5617.9438205618235;5623.381428042912;5625.071863142535;5627.296587926509;5732.484076433141;5911.142884281841;5920.37836027211;5933.317668468181;5939.524838013035;5792.102224155263;5795.130730390307;5795.130730390475;5795.623284486495;5797.739101740347;5625.971870140623;5627.352854421794;5628.605997580294;5631.1271752878365;5633.0705433603;3960.168364643457;4020.979895100506;4027.9395809062303;4059.3099173141227;4068.9796551017057;5909.438603332676;5915.467607915309;5920.2895652521975;5926.940730592639;5927.940720592739;5691.943080569141;5695.715214239354;5698.202251684685;5710.229119068873;5712;5511.145772405283;5657.151427285776;5659.6887171204335;5661.150827375926;5662.745176467151;5524.116141417354;5563;5577.860553486195;5582.162675598693;5582.888342233051;5452.345718513804;5566.721663916869;5709.65742055478;5732.455416735404;5738.5696072795545;5457.563394928476;5580.525655319343;5587.273654424899;5601.691906945157;5606.327240730975 11:33:54 INFO - PROCESS | 28070 | |5;yui.html;553.239295968044;638.1130228981716;641.8828563787108;645.7739791073125;646.7542333913112;11516.769664606712;11668.883311166886;11697.415129243547;11706.063514918796;11718.472668729906;12893.548725794599;13155.605331840035;13162.605121846336;13172.802407963889;13203.867961320384;617.6757202468694;626.583322090809;766.7546385156766;780.1769133564115;783.1111688233867;777.1257335497565;786.4652036615099;793.3890904003913;793.7420338390017;794.0749027383121;824.332290844415;831.3889291370838;831.6590198018783;831.8502669519484;832.2010869565224;642.5373730913734;652.3672038123013;791.2957467853615;808.1675873849886;821.1419067074921;586.7740919745886;594.5303210463728;594.9494292985102;595.1281372788842;595.1340799137245;11707.2975621463;11818.822717659155;11833.408329583486;11847.407629618485;11861.762764744743;10450.79098418035;10800.675979720621;10804.297720648212;10827.566897324097;11098.611548595842;8651.307895368418;8704.956475217647;8785.516796576187;9079.364444488889;9146.989153472136;3111.066679995992;3155.7159855612877;3184.26761844777;3213.53403756454;3226.774125811194;41207.58792412067;41656.79171604153;41881.79059104685;41974.580254197375;42117.36823947643;8361.372897032747;9209.815803684023;9212.401193922507;9432.245420366355;9508.239340852715;13704.65738356529;13888.305584720723;13904.860951390356;13952.372143253579;13965.511207107702;5811.724747499782;5879.323877754027;5886.94113058864;5992.940070599326;6029.427204415573;3462.376772181032;3469.2020835208045;3489.965100349015;3505.5102923412614;3507.1232191952013;2730.358365784039;2765.502209602251;2771.8614069296455;2772.029789573633;2772.7643150332046;491.608747245295;496.8161780141371;498.6036101299476;500.2446306077776;503.8488453463946;348.8639430622059;374.02277868169136;378.5344026846994;386.1369838411149;394.8677193140273;6586.73653053882;7067.43460523157;7124.7150113995895;7144.928550714426;7175.928240717631;474.99287510687367;477.95459431353964;504.1454734225526;514.8223862767339;538.4776766536531;3250.3591900450897;3309.93380132396;3326.3679900818765;3380.4760262159402;3432.3821712092063;50700.74649626728;50937.745311273204;50998;51104.48895511072;51140;42874.92812679708;43030.784846076196;43074.56925430768;43657;43769;36223.818880905426;40325.79837100796;40375.79812100979;40820.1835963285;41090.38364424596;6962.477814163856;7184.1019872515935;7297.306755858185;7372.299631534996;7407.260346042642;29267.414651706422;29518;29644.851775740983;30043.248918777204;31365;39620;40141.19717605573;40584.188316234104;40662.39006414847;40791.38812917868;9647.421154730739;9736.75658108553;9872.851907221253;9884.30809843304;9903.158231550398;10346.172306215636;10431.321964072311;10490.580376784843;10729.731756706145;11177.832332514856;9003.684871029482;9111.225545828678;9150.222231110163;9225.169734723908;9238.491882946233;9994.585438306158;10213;10245;10269.897301027193;10355.43045132525;8610.397272190887;8700.738977830675;8960.507172105597;9702.27232957517;9714.854277185988;9006.324525660733;9015.413998090104;9036.909630903607;9372.95313523428;9529.237660986966;8075.676972921017;8313.958430207811;8374.49753014821;8498.575071246289;8657.09100544459 11:33:54 INFO - PROCESS | 28070 | __end_tp_report 11:33:54 INFO - PROCESS | 28070 | __start_cc_report 11:33:54 INFO - PROCESS | 28070 | _x_x_mozilla_cycle_collect,933 11:33:54 INFO - PROCESS | 28070 | __end_cc_report 11:33:54 INFO - PROCESS | 28070 | __startTimestamp1451417634814__endTimestamp 11:33:54 INFO - PROCESS | 28070 | 11:33:54 INFO - PROCESS | 28070 | ------- Summary: start ------- 11:33:54 INFO - PROCESS | 28070 | Number of tests: 6 11:33:54 INFO - PROCESS | 28070 | 11:33:54 INFO - PROCESS | 28070 | [#0] dojo.html Cycles:165 Average:4639.76 Median:4793.54 stddev:479.34 (10.0%) stddev-sans-first:453.82 11:33:54 INFO - PROCESS | 28070 | Values: 2618.4 2720.0 2721.1 2735.5 2737.2 4525.3 4647.0 4694.5 4699.2 4699.7 4602.5 4659.9 4670.3 4672.4 4685.5 4286.7 4352.4 4367.7 4470.1 4478.4 4184.2 4388.1 4423.2 4475.3 4509.9 4216.9 4291.2 4298.0 4322.9 4334.8 4331.7 4351.3 4360.6 4395.6 4404.1 4181.4 4338.3 4352.6 4353.2 4399.5 4608.0 4608.8 4615.7 4638.6 4641.2 4944.0 5007.3 5083.8 5095.4 5145.7 5045.1 5046.5 5049.3 5057.2 5115.7 4513.9 4621.6 4677.3 4677.8 4685.4 5038.5 5139.2 5218.4 5258.1 5264.2 4939.2 4957.5 4961.3 4962.2 5000.0 4850.2 4921.6 5045.8 5052.9 5063.1 4841.3 4879.0 4988.1 4993.7 5011.3 4912.3 4917.6 4925.0 4929.0 4969.8 4085.6 4181.1 4216.4 4219.6 4269.0 3652.3 3653.0 3708.9 3710.5 3739.8 4301.7 4320.4 4322.2 4328.7 4365.2 4848.0 4964.8 5045.5 5069.5 5135.5 4220.9 4231.2 4286.1 4298.0 4323.2 4533.7 4560.4 4568.5 4573.7 4574.1 4553.9 4670.3 4793.5 4806.7 4813.0 4925.5 5028.9 5083.4 5107.3 5150.5 4812.9 4824.7 4827.0 4829.1 4873.8 4759.6 4868.0 4997.9 5002.3 5047.9 4924.7 5039.5 5109.7 5128.5 5140.2 4820.7 4870.5 4872.9 4882.8 4922.3 4714.9 4820.5 4835.6 4844.6 4881.8 4672.7 4746.3 4843.5 4857.5 4882.0 4928.5 4946.1 4948.5 4955.1 4970.6 4656.1 4835.5 4836.8 4849.5 4864.3 11:33:54 INFO - PROCESS | 28070 | 11:33:54 INFO - PROCESS | 28070 | [#1] ext.html Cycles:180 Average:38646.60 Median:18409.52 stddev:64691.63 (351.4%) stddev-sans-first:64809.61 11:33:54 INFO - PROCESS | 28070 | Values: 471.4 490.0 504.6 511.8 546.4 25017.7 25541.2 32437.2 33001.7 33056.2 35882.1 36413.6 36469.0 36471.6 36540.6 6875.8 7526.8 7678.7 7681.0 7683.4 6999.3 9516.7 9703.1 9708.4 9709.5 9388.6 9496.4 9503.9 9505.8 9510.2 7077.6 7189.3 9458.1 9466.7 9570.0 9207.2 9280.9 9289.3 9290.7 9292.2 32266.2 32930.8 32948.0 32983.8 33048.5 2655.2 2687.6 2715.3 3349.5 3425.3 26283.1 27386.6 28129.0 28433.1 28875.6 3329.1 3471.1 3475.7 3489.8 3602.0 211695.6 213370.0 214264.0 215422.9 216040.0 47639.3 48464.0 53977.5 56023.2 56060.4 47057.0 47631.3 47819.8 47882.3 47974.8 12260.8 12403.2 12403.9 12553.9 12558.2 9205.0 9376.8 9392.9 9411.6 9532.5 18294.9 18324.4 19063.2 19110.1 19130.4 6229.9 6231.9 6239.0 6302.8 6323.8 787.4 796.9 829.8 833.2 849.5 23233.5 23498.9 23676.6 23684.0 23693.9 937.1 943.4 943.6 956.3 1057.8 12630.5 12953.5 13048.2 13053.8 13064.2 326845.0 331192.0 332488.0 332550.0 334565.0 39877.8 39907.2 40375.8 41560.8 42412.4 1146.3 1176.4 1186.1 1187.0 1196.1 22427.7 22751.2 22996.7 23119.2 23223.1 30042.4 36151.8 36760.3 40384.8 41445.4 159955.0 162494.0 162722.0 163145.0 164690.2 27396.9 27838.7 27860.4 27908.3 27915.7 35768.6 36025.1 36609.5 36810.8 36900.4 32891.0 32982.5 33411.8 33922.5 34226.5 31816.0 32305.4 32481.4 32854.8 32894.7 32811.5 33469.5 33587.3 33980.0 34019.3 29396.3 30378.4 30968.5 30993.8 31009.8 23648.9 23742.9 23768.6 24065.0 24158.9 11:33:54 INFO - PROCESS | 28070 | 11:33:54 INFO - PROCESS | 28070 | [#2] jquery.html Cycles:180 Average:22838.38 Median:3802.29 stddev:64639.05 (1700.0%) stddev-sans-first:64798.29 11:33:54 INFO - PROCESS | 28070 | Values: 334.7 334.8 336.4 336.4 341.0 12407.6 12805.7 13880.7 14258.3 14510.5 12706.2 14594.9 14818.8 14888.0 14900.8 4735.1 4738.4 4854.7 4867.7 4870.0 3661.8 3770.0 4974.6 5022.4 5608.9 5690.2 5708.3 5744.2 5749.1 5750.9 5531.9 5696.5 5708.9 5715.3 5725.2 5032.6 5038.7 5047.6 5048.1 5049.6 18525.2 18894.9 19117.0 19123.2 19478.3 1426.0 1594.5 1722.7 1770.9 1820.5 8069.4 8080.6 8111.3 8426.2 10656.0 1634.5 1683.4 1689.4 1706.7 1718.7 52078.2 53680.7 54031.2 56552.4 58054.4 9148.4 9504.5 9746.7 9775.3 9810.8 12547.4 12555.8 12575.9 12586.0 12588.6 6581.6 6685.2 6719.2 6803.0 6837.7 6374.0 6387.2 6452.5 6546.4 6566.2 3834.5 3838.3 3906.0 3907.1 4012.6 1481.9 1603.2 1672.7 1683.9 1713.4 357.6 357.7 373.1 772.7 838.4 9100.9 9107.9 9293.5 9449.8 9468.0 362.8 362.9 371.7 375.3 393.7 5041.2 5203.3 8601.3 9252.6 9310.5 332114.0 333789.0 336462.0 341752.0 567939.0 63200.7 70141.6 73861.0 74767.6 77507.2 992.4 1007.4 1029.2 1030.4 1032.6 13396.2 14253.7 14257.1 14321.0 14674.8 26498.9 28817.0 30349.2 31999.7 32068.7 39232.0 40592.0 40905.2 41130.0 42332.0 8540.7 8598.6 8748.9 8765.0 8778.4 10167.9 10985.0 16381.3 16406.8 16434.0 13031.3 13797.4 13814.0 14050.2 14427.1 13491.2 13806.8 13901.3 13964.2 14273.3 13581.2 13895.6 14000.4 14123.9 14504.2 7080.5 7299.6 8183.1 8565.1 8731.6 8385.5 8494.0 10375.7 13230.3 13358.9 11:33:54 INFO - PROCESS | 28070 | 11:33:54 INFO - PROCESS | 28070 | [#3] mootools.html Cycles:180 Average:4861.92 Median:5864.57 stddev:2541.27 (43.3%) stddev-sans-first:2532.61 11:33:54 INFO - PROCESS | 28070 | Values: 1094.5 1310.5 1333.6 1396.5 1732.5 5771.8 6560.0 6593.7 6637.8 6657.6 6523.5 6646.0 6657.2 6696.4 6721.1 2013.5 2028.8 2048.6 2050.9 2054.0 2090.4 2091.4 2101.8 2141.0 2146.4 2062.8 2070.9 2094.0 2097.3 2097.4 2046.9 2067.5 2070.2 2070.9 2071.9 2069.9 2079.6 2114.6 2116.5 2117.6 7091.3 7158.4 7167.4 7174.2 7176.7 4161.2 4214.5 4228.2 4233.7 4253.9 2703.2 2706.7 2727.7 2729.8 2772.3 885.5 889.1 899.7 919.1 943.4 9704.8 9706.0 9733.1 9736.2 9743.2 3837.3 3860.9 3917.1 3941.4 3946.6 7985.1 7998.9 8007.3 8014.2 8018.1 4318.7 4335.5 4341.6 4341.9 4345.9 3213.4 3305.2 3656.8 3934.1 3960.7 3269.5 3339.9 3362.4 3372.5 3386.6 1099.8 1112.1 1114.2 1115.4 1125.5 1109.2 1134.6 1135.4 1147.5 1154.2 6536.4 6607.4 6658.4 6667.9 6684.1 404.7 416.6 421.5 424.3 425.9 5258.0 5315.8 5328.1 5335.6 5340.6 8331.8 8354.1 8467.2 8494.4 8639.3 8418.2 8515.2 8528.4 8529.2 8530.2 6575.2 6645.1 6670.6 6777.7 6798.5 6341.0 6347.8 6378.5 6380.2 6387.6 7556.4 7584.4 7815.6 7818.1 7868.7 7741.2 7832.6 7899.6 7912.1 7962.5 5104.3 5198.8 6092.6 6167.4 6188.1 6314.8 6352.4 6395.1 6397.8 6404.9 6070.9 6084.1 6169.2 6255.2 6282.2 6090.2 6120.4 6148.2 6155.7 6267.7 6071.2 6121.8 6133.4 6192.4 6226.8 5523.7 5531.9 5549.6 5560.0 5567.9 5777.5 5828.9 5860.8 5868.4 5877.1 11:33:54 INFO - PROCESS | 28070 | 11:33:54 INFO - PROCESS | 28070 | [#4] prototype.html Cycles:180 Average:4690.68 Median:5381.96 stddev:1387.46 (25.8%) stddev-sans-first:1351.58 11:33:54 INFO - PROCESS | 28070 | Values: 296.2 303.7 304.6 311.1 312.3 5370.7 5393.2 5406.9 5421.1 5446.6 5322.6 5331.4 5334.7 5342.1 5345.5 3917.0 4100.8 4111.1 4148.4 4151.7 3998.6 4088.0 4155.2 4163.0 4168.7 4106.3 4115.4 4117.8 4121.4 4162.5 3886.9 3941.2 4024.5 4159.2 4163.9 3613.4 3623.6 3637.7 3647.2 3669.3 5104.6 5141.5 5149.1 5155.6 5175.4 4743.7 4749.6 4769.4 4771.4 4775.2 5444.0 5601.1 5609.8 5619.1 5626.5 4010.6 4011.4 4013.3 4014.1 4016.5 5905.4 5906.4 5907.7 5909.3 5918.7 4133.2 4142.5 4148.9 4150.4 4154.5 3947.2 4086.9 4173.0 4202.9 4208.6 4656.5 4667.9 4673.1 4707.4 4708.2 5635.8 5641.3 5647.5 5648.0 5655.6 1423.3 1446.0 1446.5 1446.5 1446.5 943.2 959.8 976.2 978.3 981.9 4875.8 4887.7 4902.0 4902.7 4905.3 5851.1 5853.2 5855.7 5860.9 5861.4 4897.1 4897.3 4902.8 4904.1 4906.5 3071.4 3118.3 3143.6 3148.9 3156.1 5540.6 5545.3 5551.9 5589.3 5613.6 6047.1 6055.7 6060.9 6067.9 6096.5 5615.2 5617.9 5623.4 5625.1 5627.3 5732.5 5911.1 5920.4 5933.3 5939.5 5792.1 5795.1 5795.1 5795.6 5797.7 5626.0 5627.4 5628.6 5631.1 5633.1 3960.2 4021.0 4027.9 4059.3 4069.0 5909.4 5915.5 5920.3 5926.9 5927.9 5691.9 5695.7 5698.2 5710.2 5712.0 5511.1 5657.2 5659.7 5661.2 5662.7 5524.1 5563.0 5577.9 5582.2 5582.9 5452.3 5566.7 5709.7 5732.5 5738.6 5457.6 5580.5 5587.3 5601.7 5606.3 11:33:54 INFO - PROCESS | 28070 | 11:33:54 INFO - PROCESS | 28070 | [#5] yui.html Cycles:180 Average:11959.85 Median:504.00 stddev:13900.05 (2758.0%) stddev-sans-first:13912.65 11:33:54 INFO - PROCESS | 28070 | Values: 553.2 638.1 641.9 645.8 646.8 11516.8 11668.9 11697.4 11706.1 11718.5 12893.5 13155.6 13162.6 13172.8 13203.9 617.7 626.6 766.8 780.2 783.1 777.1 786.5 793.4 793.7 794.1 824.3 831.4 831.7 831.9 832.2 642.5 652.4 791.3 808.2 821.1 586.8 594.5 594.9 595.1 595.1 11707.3 11818.8 11833.4 11847.4 11861.8 10450.8 10800.7 10804.3 10827.6 11098.6 8651.3 8705.0 8785.5 9079.4 9147.0 3111.1 3155.7 3184.3 3213.5 3226.8 41207.6 41656.8 41881.8 41974.6 42117.4 8361.4 9209.8 9212.4 9432.2 9508.2 13704.7 13888.3 13904.9 13952.4 13965.5 5811.7 5879.3 5886.9 5992.9 6029.4 3462.4 3469.2 3490.0 3505.5 3507.1 2730.4 2765.5 2771.9 2772.0 2772.8 491.6 496.8 498.6 500.2 503.8 348.9 374.0 378.5 386.1 394.9 6586.7 7067.4 7124.7 7144.9 7175.9 475.0 478.0 504.1 514.8 538.5 3250.4 3309.9 3326.4 3380.5 3432.4 50700.7 50937.7 50998.0 51104.5 51140.0 42874.9 43030.8 43074.6 43657.0 43769.0 36223.8 40325.8 40375.8 40820.2 41090.4 6962.5 7184.1 7297.3 7372.3 7407.3 29267.4 29518.0 29644.9 30043.2 31365.0 39620.0 40141.2 40584.2 40662.4 40791.4 9647.4 9736.8 9872.9 9884.3 9903.2 10346.2 10431.3 10490.6 10729.7 11177.8 9003.7 9111.2 9150.2 9225.2 9238.5 9994.6 10213.0 10245.0 10269.9 10355.4 8610.4 8700.7 8960.5 9702.3 9714.9 9006.3 9015.4 9036.9 9373.0 9529.2 8075.7 8314.0 8374.5 8498.6 8657.1 11:33:54 INFO - PROCESS | 28070 | -------- Summary: end -------- 11:33:54 INFO - PROCESS | 28070 | 11:33:55 INFO - TEST-INFO | 28070: exit 0 11:33:55 INFO - TEST-OK | dromaeo_css | took 1118108ms 11:33:55 INFO - TEST-START | kraken 11:33:55 INFO - operating with platform_type : linux_ 11:33:55 INFO - Initialising browser for kraken test... 11:33:55 INFO - TEST-INFO | started process 28265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJnzYk/profile http://localhost:46865/getInfo.html) 11:34:00 INFO - PROCESS | 28265 | __metrics Screen width/height:1600/1200 11:34:00 INFO - PROCESS | 28265 | colorDepth:24 11:34:00 INFO - PROCESS | 28265 | Browser inner width/height: 1024/697 11:34:00 INFO - PROCESS | 28265 | __metrics 11:34:00 INFO - PROCESS | 28265 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:34:00 INFO - PROCESS | 28265 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:01 INFO - TEST-INFO | 28265: exit 0 11:34:01 INFO - Browser initialized. 11:34:01 INFO - Running cycle 1/1 for kraken test... 11:34:01 INFO - TEST-INFO | started process 28347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJnzYk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:13 INFO - PROCESS | 28347 | RSS: Main: 150401024 11:34:13 INFO - PROCESS | 28347 | 11:34:16 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46865/tests/kraken/driver.html?testName=audio-beat-detection) 11:34:16 INFO - PROCESS | 28347 | RSS: Main: 186163200 11:34:16 INFO - PROCESS | 28347 | 11:34:19 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46865/tests/kraken/driver.html?testName=audio-dft) 11:34:20 INFO - PROCESS | 28347 | RSS: Main: 175497216 11:34:20 INFO - PROCESS | 28347 | 11:34:23 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46865/tests/kraken/driver.html?testName=audio-fft) 11:34:23 INFO - PROCESS | 28347 | RSS: Main: 160350208 11:34:23 INFO - PROCESS | 28347 | 11:34:25 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46865/tests/kraken/driver.html?testName=audio-oscillator) 11:34:26 INFO - PROCESS | 28347 | RSS: Main: 164007936 11:34:26 INFO - PROCESS | 28347 | 11:34:28 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46865/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:34:29 INFO - PROCESS | 28347 | RSS: Main: 164020224 11:34:29 INFO - PROCESS | 28347 | 11:34:32 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46865/tests/kraken/driver.html?testName=imaging-darkroom) 11:34:32 INFO - PROCESS | 28347 | RSS: Main: 164167680 11:34:32 INFO - PROCESS | 28347 | 11:34:36 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46865/tests/kraken/driver.html?testName=imaging-desaturate) 11:34:36 INFO - PROCESS | 28347 | RSS: Main: 164859904 11:34:36 INFO - PROCESS | 28347 | 11:34:39 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46865/tests/kraken/driver.html?testName=json-parse-financial) 11:34:40 INFO - PROCESS | 28347 | RSS: Main: 164569088 11:34:40 INFO - PROCESS | 28347 | 11:34:41 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46865/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:34:42 INFO - PROCESS | 28347 | RSS: Main: 176832512 11:34:42 INFO - PROCESS | 28347 | 11:34:44 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46865/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:34:44 INFO - PROCESS | 28347 | RSS: Main: 175448064 11:34:44 INFO - PROCESS | 28347 | 11:34:47 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46865/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:34:47 INFO - PROCESS | 28347 | RSS: Main: 189542400 11:34:47 INFO - PROCESS | 28347 | 11:34:50 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:50 INFO - PROCESS | 28347 | RSS: Main: 192143360 11:34:50 INFO - PROCESS | 28347 | 11:34:53 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:53 INFO - PROCESS | 28347 | RSS: Main: 190013440 11:34:53 INFO - PROCESS | 28347 | 11:34:55 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:46865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46865/tests/kraken/driver.html?testName=ai-astar) 11:34:56 INFO - PROCESS | 28347 | RSS: Main: 248680448 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | __start_tp_report 11:34:56 INFO - PROCESS | 28347 | _x_x_mozilla_page_load 11:34:56 INFO - PROCESS | 28347 | _x_x_mozilla_page_load_details 11:34:56 INFO - PROCESS | 28347 | |i|pagename|runs| 11:34:56 INFO - PROCESS | 28347 | |0;ai-astar;110;112;108;111;112;114;100;112;111;103 11:34:56 INFO - PROCESS | 28347 | |1;audio-beat-detection;155;128;155;165;131;155;158;128;165;130 11:34:56 INFO - PROCESS | 28347 | |2;audio-dft;161;170;160;159;162;162;161;164;161;162 11:34:56 INFO - PROCESS | 28347 | |3;audio-fft;74;73;81;91;74;82;73;94;98;72 11:34:56 INFO - PROCESS | 28347 | |4;audio-oscillator;96;96;137;96;98;97;141;96;98;133 11:34:56 INFO - PROCESS | 28347 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;109 11:34:56 INFO - PROCESS | 28347 | |6;imaging-darkroom;147;147;146;147;146;146;147;146;147;146 11:34:56 INFO - PROCESS | 28347 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 11:34:56 INFO - PROCESS | 28347 | |8;json-parse-financial;71;70;71;71;70;70;69;79;69;69 11:34:56 INFO - PROCESS | 28347 | |9;json-stringify-tinderbox;68;69;68;69;70;69;69;69;69;69 11:34:56 INFO - PROCESS | 28347 | |10;stanford-crypto-aes;92;84;84;85;84;85;92;84;85;87 11:34:56 INFO - PROCESS | 28347 | |11;stanford-crypto-ccm;124;137;126;120;124;117;129;119;128;120 11:34:56 INFO - PROCESS | 28347 | |12;stanford-crypto-pbkdf2;137;148;139;139;147;137;150;149;160;140 11:34:56 INFO - PROCESS | 28347 | |13;stanford-crypto-sha256-iterative;71;70;69;69;69;77;68;69;69;73 11:34:56 INFO - PROCESS | 28347 | __end_tp_report 11:34:56 INFO - PROCESS | 28347 | __start_cc_report 11:34:56 INFO - PROCESS | 28347 | _x_x_mozilla_cycle_collect,985 11:34:56 INFO - PROCESS | 28347 | __end_cc_report 11:34:56 INFO - PROCESS | 28347 | __startTimestamp1451417696011__endTimestamp 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | ------- Summary: start ------- 11:34:56 INFO - PROCESS | 28347 | Number of tests: 14 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.50 stddev:4.45 (4.0%) stddev-sans-first:4.71 11:34:56 INFO - PROCESS | 28347 | Values: 110.0 112.0 108.0 111.0 112.0 114.0 100.0 112.0 111.0 103.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:155.00 stddev:15.73 (10.2%) stddev-sans-first:16.42 11:34:56 INFO - PROCESS | 28347 | Values: 155.0 128.0 155.0 165.0 131.0 155.0 158.0 128.0 165.0 130.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:3.05 (1.9%) stddev-sans-first:3.20 11:34:56 INFO - PROCESS | 28347 | Values: 161.0 170.0 160.0 159.0 162.0 162.0 161.0 164.0 161.0 162.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#3] audio-fft Cycles:10 Average:81.20 Median:81.50 stddev:9.81 (12.0%) stddev-sans-first:10.05 11:34:56 INFO - PROCESS | 28347 | Values: 74.0 73.0 81.0 91.0 74.0 82.0 73.0 94.0 98.0 72.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:96.00 stddev:19.57 (20.4%) stddev-sans-first:20.20 11:34:56 INFO - PROCESS | 28347 | Values: 96.0 96.0 137.0 96.0 98.0 97.0 141.0 96.0 98.0 133.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:34:56 INFO - PROCESS | 28347 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:34:56 INFO - PROCESS | 28347 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:34:56 INFO - PROCESS | 28347 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#8] json-parse-financial Cycles:10 Average:70.90 Median:70.50 stddev:2.96 (4.2%) stddev-sans-first:3.14 11:34:56 INFO - PROCESS | 28347 | Values: 71.0 70.0 71.0 71.0 70.0 70.0 69.0 79.0 69.0 69.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 11:34:56 INFO - PROCESS | 28347 | Values: 68.0 69.0 68.0 69.0 70.0 69.0 69.0 69.0 69.0 69.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.00 stddev:3.19 (3.8%) stddev-sans-first:2.60 11:34:56 INFO - PROCESS | 28347 | Values: 92.0 84.0 84.0 85.0 84.0 85.0 92.0 84.0 85.0 87.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:125.00 stddev:5.95 (4.8%) stddev-sans-first:6.31 11:34:56 INFO - PROCESS | 28347 | Values: 124.0 137.0 126.0 120.0 124.0 117.0 129.0 119.0 128.0 120.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:147.50 stddev:7.47 (5.1%) stddev-sans-first:7.40 11:34:56 INFO - PROCESS | 28347 | Values: 137.0 148.0 139.0 139.0 147.0 137.0 150.0 149.0 160.0 140.0 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - PROCESS | 28347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:69.50 stddev:2.72 (3.9%) stddev-sans-first:2.87 11:34:56 INFO - PROCESS | 28347 | Values: 71.0 70.0 69.0 69.0 69.0 77.0 68.0 69.0 69.0 73.0 11:34:56 INFO - PROCESS | 28347 | -------- Summary: end -------- 11:34:56 INFO - PROCESS | 28347 | 11:34:56 INFO - TEST-INFO | 28347: exit 0 11:34:57 INFO - TEST-OK | kraken | took 61378ms 11:34:57 INFO - TEST-START | v8_7 11:34:57 INFO - operating with platform_type : linux_ 11:34:57 INFO - Initialising browser for v8_7 test... 11:34:57 INFO - TEST-INFO | started process 28593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKLxZ7y/profile http://localhost:46865/getInfo.html) 11:35:01 INFO - PROCESS | 28593 | __metrics Screen width/height:1600/1200 11:35:01 INFO - PROCESS | 28593 | colorDepth:24 11:35:01 INFO - PROCESS | 28593 | Browser inner width/height: 1024/697 11:35:01 INFO - PROCESS | 28593 | __metrics 11:35:01 INFO - PROCESS | 28593 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:35:01 INFO - PROCESS | 28593 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:35:03 INFO - TEST-INFO | 28593: exit 0 11:35:03 INFO - Browser initialized. 11:35:03 INFO - Running cycle 1/1 for v8_7 test... 11:35:03 INFO - TEST-INFO | started process 28677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKLxZ7y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:15 INFO - PROCESS | 28677 | RSS: Main: 148566016 11:35:15 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | Cycle 1(1): loaded http://localhost:46865/tests/v8_7/run.html (next: http://localhost:46865/tests/v8_7/run.html) 11:35:36 INFO - PROCESS | 28677 | RSS: Main: 452521984 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | __start_tp_report 11:35:36 INFO - PROCESS | 28677 | _x_x_mozilla_page_load 11:35:36 INFO - PROCESS | 28677 | _x_x_mozilla_page_load_details 11:35:36 INFO - PROCESS | 28677 | |i|pagename|runs| 11:35:36 INFO - PROCESS | 28677 | |0;Richards;166.08536787908986 11:35:36 INFO - PROCESS | 28677 | |1;DeltaBlue;187.68768768768768 11:35:36 INFO - PROCESS | 28677 | |2;Encrypt;278.31895352073474 11:35:36 INFO - PROCESS | 28677 | |3;Decrypt;5235.602094240838 11:35:36 INFO - PROCESS | 28677 | |4;RayTrace;2024.2914979757086 11:35:36 INFO - PROCESS | 28677 | |5;Earley;811.6883116883117 11:35:36 INFO - PROCESS | 28677 | |6;Boyer;12048.192771084337 11:35:36 INFO - PROCESS | 28677 | |7;RegExp;26710.526315789473 11:35:36 INFO - PROCESS | 28677 | |8;Splay;599.1611743559017 11:35:36 INFO - PROCESS | 28677 | |9;NavierStokes;4826.923076923077 11:35:36 INFO - PROCESS | 28677 | __end_tp_report 11:35:36 INFO - PROCESS | 28677 | __startTimestamp1451417736705__endTimestamp 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | ------- Summary: start ------- 11:35:36 INFO - PROCESS | 28677 | Number of tests: 10 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 166.1 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#1] DeltaBlue Cycles:1 Average:187.69 Median:187.69 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 187.7 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 278.3 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 5235.6 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#4] RayTrace Cycles:1 Average:2024.29 Median:2024.29 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 2024.3 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#5] Earley Cycles:1 Average:811.69 Median:811.69 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 811.7 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 12048.2 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 26710.5 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#8] Splay Cycles:1 Average:599.16 Median:599.16 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 599.2 11:35:36 INFO - PROCESS | 28677 | 11:35:36 INFO - PROCESS | 28677 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 28677 | Values: 4826.9 11:35:36 INFO - PROCESS | 28677 | -------- Summary: end -------- 11:35:36 INFO - PROCESS | 28677 | 11:35:37 INFO - TEST-INFO | 28677: exit 0 11:35:37 INFO - TEST-OK | v8_7 | took 40641ms 11:35:37 INFO - SUITE-END | took 1220s 11:35:37 INFO - Completed test suite (00:20:20) 11:35:37 INFO - Working with test: dromaeo_css 11:35:37 INFO - Generating results file: dromaeo_css 11:35:37 INFO - Working with test: kraken 11:35:37 INFO - Generating results file: kraken 11:35:37 INFO - javascript benchmark 11:35:37 INFO - Working with test: v8_7 11:35:37 INFO - Generating results file: v8_7 11:35:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:35:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 11:35:37 INFO - process_Request line: dromaeo_css 6082.36 graph.html#tests=[[72,203,35]] 11:35:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:35:38 INFO - process_Request line: kraken 1524.60 graph.html#tests=[[232,203,35]] 11:35:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:35:38 INFO - process_Request line: v8_7 19735.21 graph.html#tests=[[230,203,35]] 11:35:38 INFO - RETURN: dromaeo_css: 6082.36 11:35:38 INFO - RETURN: kraken: 1524.60 11:35:38 INFO - RETURN: v8_7: 19735.21 11:35:38 INFO - javascript benchmark 11:35:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2618.4370360372523, 2720.0207925146956, 2721.0748345562506, 2735.4802587508384, 2737.247257004324, 4525.343825145352, 4647.0, 4694.507076756939, 4699.2011358069085, 4699.7415142167165, 4602.516735742741, 4659.883502912429, 4670.2527595584625, 4672.415948006499, 4685.508021657728, 4286.699931004831, 4352.368906508555, 4367.650587952964, 4470.083632855257, 4478.440194975628, 4184.225918205127, 4388.144311859189, 4423.203823311803, 4475.283954567253, 4509.864704058883, 4216.852410165629, 4291.227579035773, 4298.0, 4322.891927701832, 4334.761588112652, 4331.7184383015, 4351.28203846365, 4360.563943605645, 4395.604395604411, 4404.0531285773395, 4181.372794080912, 4338.284183109783, 4352.608265256111, 4353.194658988097, 4399.494058183318, 4607.953920460786, 4608.8386906458445, 4615.699979501322, 4638.582527572535, 4641.164590373732, 4944.0, 5007.298978143063, 5083.771230294646, 5095.363079615048, 5145.742712864379, 5045.117104506697, 5046.545810877039, 5049.3183420238165, 5057.165567681328, 5115.667481613683, 4513.864584062483, 4621.560951709582, 4677.298405239173, 4677.7661116944355, 4685.4143232095985, 5038.496150384932, 5139.177731562932, 5218.399884013387, 5258.07983602868, 5264.210368444764, 4939.209726443752, 4957.529034741694, 4961.305417241589, 4962.230854217602, 5000.024995125916, 4850.1997170466475, 4921.606271498272, 5045.84862454127, 5052.949470505321, 5063.11395505785, 4841.346418233564, 4879.048585525859, 4988.052270068675, 4993.700377977333, 5011.323471331397, 4912.336834527293, 4917.606591472673, 4924.9507504925205, 4929.0, 4969.801207951714, 4085.632293093636, 4181.059261666101, 4216.388623649554, 4219.578042195756, 4268.978655106766, 3652.3060618482405, 3653.0319465341177, 3708.9072773180346, 3710.5176327077306, 3739.794311312904, 4301.698881078294, 4320.351947207944, 4322.222000040023, 4328.653707703439, 4365.236083685342, 4848.0, 4964.751762411865, 5045.520675535819, 5069.518395752398, 5135.486451354835, 4220.894477638084, 4231.217224813419, 4286.142771445661, 4298.0, 4323.2434323993175, 4533.659975501851, 4560.4071470708595, 4568.543145685405, 4573.748443835621, 4574.108048930493, 4553.9089218214785, 4670.322803193586, 4793.544613261734, 4806.735629540339, 4812.951870481251, 4925.507449255046, 5028.874278143076, 5083.38999320084, 5107.284980102714, 5150.48495150482, 4812.927806082842, 4824.6863953842885, 4827.0, 4829.13075646387, 4873.805047798191, 4759.571638552547, 4868.002059577707, 4997.925031124463, 5002.299678045004, 5047.949520504748, 4924.729139897197, 5039.546440820343, 5109.69341839476, 5128.512791284822, 5140.203268493389, 4820.662553621353, 4870.537298956593, 4872.878178045577, 4882.82910098159, 4922.335484709519, 4714.882127946828, 4820.542048505386, 4835.58897493717, 4844.612431005582, 4881.829135980223, 4672.696274742131, 4746.335513028248, 4843.491433399583, 4857.514248575114, 4882.048000639983, 4928.457869634409, 4946.060248552763, 4948.529889660476, 4955.083309587738, 4970.62720295972, 4656.068786242833, 4835.540623640749, 4836.830710925101, 4849.466558678472, 4864.270359446112], "unit": "score", "name": "dojo.html", "value": 4610.392304287921}, {"lowerIsBetter": false, "replicates": [471.4389876047503, 490.0468588595182, 504.60892808073737, 511.797839853258, 546.3716725765366, 25017.74840264376, 25541.233762987118, 32437.189070273227, 33001.66998330016, 33056.17359566006, 35882.10294742633, 36413.63586364136, 36469.0, 36471.635283647156, 36540.63459365405, 6875.828104297382, 7526.849463010736, 7678.654460549289, 7681.039870016248, 7683.385329173652, 6999.335063168991, 9516.666916657918, 9703.126718595326, 9708.417494950325, 9709.465979371133, 9388.62445502179, 9496.430214187136, 9503.90496095037, 9505.762355941088, 9510.239180865548, 7077.646117694095, 7189.2810718927685, 9458.148766611039, 9466.66866659667, 9569.952150239274, 9207.217386522087, 9280.90719092814, 9289.303302252358, 9290.674826381044, 9292.210162136227, 32266.193345166324, 32930.835345823354, 32948.0, 32983.83508082468, 33048.50427243593, 2655.150351887397, 2687.6102965069954, 2715.321169707573, 3349.5478110455265, 3425.3491836550975, 26283.08009219668, 27386.589201161798, 28129.0, 28433.147005589864, 28875.566866497018, 3329.0845017620104, 3471.1495683557437, 3475.6524347565296, 3489.8255087245534, 3602.0274525877867, 211695.59652841603, 213370.0, 214264.0, 215422.92288538613, 216040.0, 47639.28541071887, 48464.0, 53977.46022539803, 56023.159652605245, 56060.43939560552, 47057.0, 47631.28553071707, 47819.76090119527, 47882.28176577354, 47974.76012619984, 12260.75478490443, 12403.193792403465, 12403.875961240452, 12553.874461255271, 12558.246505209716, 9205.0, 9376.812463750823, 9392.906070939203, 9411.623535058521, 9532.475713835667, 18294.908525457555, 18324.358647447276, 19063.237470501303, 19110.140043698066, 19130.426087217405, 6229.906551401733, 6231.875362492725, 6239.0, 6302.842428939313, 6323.810285691437, 787.3897729259869, 796.9163237860057, 829.8340331933638, 833.2126140796888, 849.4775712936499, 23233.535329293318, 23498.882505587364, 23676.64485032726, 23684.0, 23693.881530592236, 937.1097457415483, 943.4009404028354, 943.5753910740194, 956.2636769687302, 1057.8466122412208, 12630.483271375464, 12953.54662586805, 13048.151870128411, 13053.804192937114, 13064.150830196008, 326845.0, 331192.0, 332488.0, 332550.0, 334565.0, 39877.80061099676, 39907.20185596272, 40375.798121009204, 41560.79219603883, 42412.363814542805, 1146.2721172055637, 1176.4353110507004, 1186.128195776104, 1186.95845645402, 1196.0909708621336, 22427.66358504591, 22751.203707870147, 22996.655050174595, 23119.190828320927, 23223.0710771574, 30042.399152017275, 36151.81924090363, 36760.26479470449, 40384.79807601061, 41445.40487034332, 159955.0, 162494.0, 162722.0, 163145.0, 164690.1765491165, 27396.863015684794, 27838.721612784422, 27860.442791143658, 27908.30229244285, 27915.720842792125, 35768.64231357653, 36025.0993725159, 36609.45085823768, 36810.8159459201, 36900.446493303156, 32891.0, 32982.50526242156, 33411.83294083611, 33922.49116263209, 34226.48660270148, 31816.045518634477, 32305.35389292248, 32481.35037299288, 32854.83572582122, 32894.67105328916, 32811.539134564526, 33469.497957531144, 33587.32825343431, 33980.0, 34019.31961360709, 29396.265093372836, 30378.39243215079, 30968.53547196839, 30993.8450307747, 31009.844950775103, 23648.881755591112, 23742.881285593463, 23768.64347034761, 24065.0, 24158.87920560386], "unit": "score", "name": "ext.html", "value": 16101.259358869795}, {"lowerIsBetter": false, "replicates": [334.6887394722908, 334.7924286942096, 336.3844165177724, 336.3877742508635, 340.9982950085249, 12407.627771166857, 12805.679858003554, 13880.6529836754, 14258.287085645716, 14510.492132775342, 12706.17409868358, 14594.927025364857, 14818.777718334233, 14888.0, 14900.776488352683, 4735.076660051292, 4738.431388233417, 4854.732989685566, 4867.68360056597, 4870.0, 3661.7986010769396, 3770.0386401467586, 4974.552290293873, 5022.447530771612, 5608.887822243552, 5690.231818704484, 5708.343540492855, 5744.195812586241, 5749.080147176453, 5750.913736293959, 5531.944680553203, 5696.487316141525, 5708.91436628453, 5715.257016587838, 5725.227094342252, 5032.597392208614, 5038.697678139287, 5047.570956468705, 5048.14181589127, 5049.570786483153, 18525.16636751336, 18894.905525472423, 19117.0, 19123.23507059716, 19478.318258860872, 1425.9572212833632, 1594.5455545169687, 1722.715751900935, 1770.9380171693929, 1820.4629634257794, 8069.354451643854, 8080.636371363303, 8111.310538604226, 8426.157384261585, 10656.04095631397, 1634.4933070748107, 1683.3823404605832, 1689.374931275436, 1706.6501367219814, 1718.7023797033285, 52078.21882671725, 53680.73159634216, 54031.18953215705, 56552.43447565513, 58054.41945580574, 9148.359614826899, 9504.524773761423, 9746.707598772047, 9775.266854985905, 9810.80378392428, 12547.435365408579, 12555.811662825065, 12575.874241257654, 12586.0, 12588.559400420942, 6581.638009909501, 6685.164354455693, 6719.160104986877, 6803.0, 6837.726490940406, 6374.043893415932, 6387.23747497982, 6452.483801295885, 6546.378094081055, 6566.179227596551, 3834.539855217336, 3838.2707285615643, 3905.9804700976883, 3907.081835768592, 4012.6388625023305, 1481.8666320031034, 1603.2144249317982, 1672.715638341485, 1683.8867221637013, 1713.366054559821, 357.64235764235764, 357.6959584353279, 373.1250218238227, 772.7063715787965, 838.421489172469, 9100.8634870477, 9107.908920910839, 9293.488858112734, 9449.763755906157, 9467.952660236793, 362.82765686298796, 362.9110867837344, 371.6655010490526, 375.2907005759117, 393.7381641208564, 5041.193409054534, 5203.297554830049, 8601.268892144239, 9252.583633736498, 9310.487923164292, 332114.0, 333789.0, 336462.0, 341752.0, 567939.0, 63200.683996579726, 70141.64929175322, 73861.0, 74767.62616186884, 77507.22492775, 992.4442312304988, 1007.3804610164696, 1029.2280789408094, 1030.386919782743, 1032.5869652139204, 13396.196228226338, 14253.714925701635, 14257.144571325338, 14321.0, 14674.77987830162, 26498.867505662347, 28817.0, 30349.241268968453, 31999.68000319967, 32068.67931320657, 39232.0, 40592.0, 40905.181896362505, 41130.0, 42332.0, 8540.701075462577, 8598.570071496526, 8748.868766968373, 8765.0, 8778.429402088845, 10167.949160254151, 10985.0, 16381.344746210018, 16406.753898691768, 16434.0, 13031.283279419724, 13797.448102075805, 13814.0, 14050.156990580597, 14427.062240954305, 13491.190528568317, 13806.792898106738, 13901.304934753423, 13964.162150271017, 14273.286335683382, 13581.185128892299, 13895.58313250604, 14000.43998240059, 14123.858761412253, 14504.202268875313, 7080.468964827762, 7299.6350182489605, 8183.140770219279, 8565.100664430145, 8731.607077681392, 8385.53879536607, 8494.023187333536, 10375.740606484898, 13230.272335021282, 13358.933205333911], "unit": "score", "name": "jquery.html", "value": 7544.365726368187}, {"lowerIsBetter": false, "replicates": [1094.485591771868, 1310.5478609879592, 1333.6199183232777, 1396.5112210726247, 1732.4629364896882, 5771.769129234831, 6560.0, 6593.736250549984, 6637.834054148649, 6657.600543967365, 6523.532205253816, 6645.969874669434, 6657.167854018247, 6696.397324240817, 6721.126253587039, 2013.506690860734, 2028.7971202879667, 2048.6312463756517, 2050.8666936649147, 2053.9589208215825, 2090.4042347930845, 2091.4144039668918, 2101.8003289687454, 2141.0, 2146.431195733132, 2062.8040336168115, 2070.9378718638463, 2094.036743098177, 2097.3393381084984, 2097.402240361497, 2046.94882627934, 2067.472794437409, 2070.171931227506, 2070.87574745515, 2071.8756874587575, 2069.896505174735, 2079.6360636888635, 2114.619368513667, 2116.4603026228215, 2117.5658989907033, 7091.255418181068, 7158.355747982707, 7167.354938055548, 7174.174969878479, 7176.7488137914925, 4161.2301724181125, 4214.536400995888, 4228.238916994939, 4233.724807887477, 4253.893652658678, 2703.1620197738566, 2706.742859428351, 2727.7135900730536, 2729.767969722576, 2772.334639686481, 885.4952676974063, 889.0842432294746, 899.7255836969722, 919.0579655852738, 943.3585162089777, 9704.805903881954, 9706.0, 9733.124018838338, 9736.172425343855, 9743.171830394425, 3837.2901013312626, 3860.9227815443533, 3917.05990562263, 3941.38908469182, 3946.6053394660303, 7985.081715602664, 7998.880016799752, 8007.279344858991, 8014.15851335613, 8018.077921039155, 4318.719283246579, 4335.501417337046, 4341.60925516705, 4341.9131617367475, 4345.891352716144, 3213.4215841148352, 3305.2397948471985, 3656.8171591420323, 3934.055826601595, 3960.7029472789654, 3269.54226408303, 3339.899803005914, 3362.3779600773937, 3372.51098590703, 3386.593608766964, 1099.7855418193376, 1112.1158678850334, 1114.1977776001265, 1115.4367044642404, 1125.4935279124427, 1109.1681239070697, 1134.6142311614092, 1135.3982389333667, 1147.512307269407, 1154.2382027861572, 6536.444402225769, 6607.405333520006, 6658.3674550917585, 6667.86664266712, 6684.097646817618, 404.7450106432987, 416.61046921128843, 421.4521122540685, 424.31684987171246, 425.8743670617175, 5258.0009798138235, 5315.840524784263, 5328.094223981932, 5335.626506144533, 5340.626156169109, 8331.8333633327, 8354.081051084377, 8467.195616416431, 8494.428530721712, 8639.265662418766, 8418.158184181655, 8515.19105684959, 8528.445651032787, 8529.232369086812, 8530.232279094911, 6575.178102737158, 6645.1361323027695, 6670.633115178614, 6777.661116944133, 6798.490113241527, 6341.0, 6347.841303967253, 6378.45783108441, 6380.202474690664, 6387.584806987531, 7556.433267504849, 7584.393248540214, 7815.570143642154, 7818.061832580127, 7868.72459463916, 7741.1871753465075, 7832.647530861011, 7899.644515996679, 7912.0901096374655, 7962.482438641469, 5104.285400043923, 5198.792048318025, 6092.603980741238, 6167.414095660905, 6188.1027251049245, 6314.842128946813, 6352.36476352361, 6395.136656551306, 6397.840053998687, 6404.93595064062, 6070.939290607037, 6084.148219249397, 6169.167162433194, 6255.155554000152, 6282.1519094921605, 6090.23872015998, 6120.387961203844, 6148.231471066117, 6155.692215389302, 6267.717952692231, 6071.180390647206, 6121.816345509642, 6133.417325354084, 6192.442680158807, 6226.782062627786, 5523.696196709059, 5531.917021244604, 5549.611527193058, 5559.972200138974, 5567.944320556742, 5777.508911742549, 5828.854278643068, 5860.765569377178, 5868.38381969887, 5877.118432235199], "unit": "score", "name": "mootools.html", "value": 3936.0871598699846}, {"lowerIsBetter": false, "replicates": [296.17515220111966, 303.7478892519208, 304.6450884719302, 311.1102247571944, 312.302005018783, 5370.731463426832, 5393.1910213468, 5406.945930540694, 5421.1326187809955, 5446.645968012086, 5322.600804939626, 5331.386890507592, 5334.67991920485, 5342.0651386007485, 5345.49217824307, 3916.9815847879613, 4100.815463304143, 4111.09555897702, 4148.398482220076, 4151.709380343377, 3998.5601583825755, 4087.9591204087874, 4155.231282212785, 4163.02168990287, 4168.729032612886, 4106.32245679464, 4115.36211887158, 4117.794110294488, 4121.381792731099, 4162.500499939996, 3886.9028274293087, 3941.1920556286177, 4024.5170579530645, 4159.209750147463, 4163.91672166555, 3613.421852503613, 3623.58328792187, 3637.672609465161, 3647.2340808430263, 3669.321175582526, 5104.64267501275, 5141.511556402136, 5149.124648809711, 5155.5617772489, 5175.378954525443, 4743.715377077387, 4749.57253847152, 4769.427668679746, 4771.403574553181, 4775.164346239394, 5444.0, 5601.075822489284, 5609.831705048855, 5619.072852979253, 5626.549876009909, 4010.5588385277597, 4011.3581826907553, 4013.2776100301935, 4014.096828213658, 4016.477857878457, 5905.350411454737, 5906.350301466835, 5907.700305932731, 5909.320428150775, 5918.733656985446, 4133.23535145999, 4142.482189726285, 4148.896277593084, 4150.439690641725, 4154.543000269968, 3947.210557888434, 4086.8773936781945, 4173.040200753843, 4202.894927626834, 4208.579142085767, 4656.511066338054, 4667.8599642010795, 4673.088747694167, 4707.411573553306, 4708.246680531167, 5635.774569017275, 5641.26663533738, 5647.548196144298, 5648.039833228361, 5655.632383895034, 1423.3168079321983, 1445.966134214042, 1446.4792674637122, 1446.4864972934668, 1446.5443385333585, 943.1605870775015, 959.8464245720651, 976.1800087926176, 978.3054031637618, 981.9410835349759, 4875.780589873464, 4887.73117478535, 4902.0, 4902.730349830722, 4905.264210368473, 5851.093080572518, 5853.180554722342, 5855.707214639251, 5860.941390586039, 5861.443162899518, 4897.069556784271, 4897.265410188429, 4902.803887844446, 4904.068227036852, 4906.484819094015, 3071.385722855393, 3118.251619611277, 3143.5913331267247, 3148.874045038219, 3156.0847354267466, 5540.612157149041, 5545.251391062155, 5551.916721249185, 5589.301337332833, 5613.635113717595, 6047.12316714074, 6055.7274922628585, 6060.939390606126, 6067.908981365283, 6096.481799047042, 5615.18579805934, 5617.9438205618235, 5623.381428042912, 5625.071863142535, 5627.296587926509, 5732.484076433141, 5911.142884281841, 5920.37836027211, 5933.317668468181, 5939.524838013035, 5792.102224155263, 5795.130730390307, 5795.130730390475, 5795.623284486495, 5797.739101740347, 5625.971870140623, 5627.352854421794, 5628.605997580294, 5631.1271752878365, 5633.0705433603, 3960.168364643457, 4020.979895100506, 4027.9395809062303, 4059.3099173141227, 4068.9796551017057, 5909.438603332676, 5915.467607915309, 5920.2895652521975, 5926.940730592639, 5927.940720592739, 5691.943080569141, 5695.715214239354, 5698.202251684685, 5710.229119068873, 5712.0, 5511.145772405283, 5657.151427285776, 5659.6887171204335, 5661.150827375926, 5662.745176467151, 5524.116141417354, 5563.0, 5577.860553486195, 5582.162675598693, 5582.888342233051, 5452.345718513804, 5566.721663916869, 5709.65742055478, 5732.455416735404, 5738.5696072795545, 5457.563394928476, 5580.525655319343, 5587.273654424899, 5601.691906945157, 5606.327240730975], "unit": "score", "name": "prototype.html", "value": 4243.016925554522}, {"lowerIsBetter": false, "replicates": [553.239295968044, 638.1130228981716, 641.8828563787108, 645.7739791073125, 646.7542333913112, 11516.769664606712, 11668.883311166886, 11697.415129243547, 11706.063514918796, 11718.472668729906, 12893.548725794599, 13155.605331840035, 13162.605121846336, 13172.802407963889, 13203.867961320384, 617.6757202468694, 626.583322090809, 766.7546385156766, 780.1769133564115, 783.1111688233867, 777.1257335497565, 786.4652036615099, 793.3890904003913, 793.7420338390017, 794.0749027383121, 824.332290844415, 831.3889291370838, 831.6590198018783, 831.8502669519484, 832.2010869565224, 642.5373730913734, 652.3672038123013, 791.2957467853615, 808.1675873849886, 821.1419067074921, 586.7740919745886, 594.5303210463728, 594.9494292985102, 595.1281372788842, 595.1340799137245, 11707.2975621463, 11818.822717659155, 11833.408329583486, 11847.407629618485, 11861.762764744743, 10450.79098418035, 10800.675979720621, 10804.297720648212, 10827.566897324097, 11098.611548595842, 8651.307895368418, 8704.956475217647, 8785.516796576187, 9079.364444488889, 9146.989153472136, 3111.066679995992, 3155.7159855612877, 3184.26761844777, 3213.53403756454, 3226.774125811194, 41207.58792412067, 41656.79171604153, 41881.79059104685, 41974.580254197375, 42117.36823947643, 8361.372897032747, 9209.815803684023, 9212.401193922507, 9432.245420366355, 9508.239340852715, 13704.65738356529, 13888.305584720723, 13904.860951390356, 13952.372143253579, 13965.511207107702, 5811.724747499782, 5879.323877754027, 5886.94113058864, 5992.940070599326, 6029.427204415573, 3462.376772181032, 3469.2020835208045, 3489.965100349015, 3505.5102923412614, 3507.1232191952013, 2730.358365784039, 2765.502209602251, 2771.8614069296455, 2772.029789573633, 2772.7643150332046, 491.608747245295, 496.8161780141371, 498.6036101299476, 500.2446306077776, 503.8488453463946, 348.8639430622059, 374.02277868169136, 378.5344026846994, 386.1369838411149, 394.8677193140273, 6586.73653053882, 7067.43460523157, 7124.7150113995895, 7144.928550714426, 7175.928240717631, 474.99287510687367, 477.95459431353964, 504.1454734225526, 514.8223862767339, 538.4776766536531, 3250.3591900450897, 3309.93380132396, 3326.3679900818765, 3380.4760262159402, 3432.3821712092063, 50700.74649626728, 50937.745311273204, 50998.0, 51104.48895511072, 51140.0, 42874.92812679708, 43030.784846076196, 43074.56925430768, 43657.0, 43769.0, 36223.818880905426, 40325.79837100796, 40375.79812100979, 40820.1835963285, 41090.38364424596, 6962.477814163856, 7184.1019872515935, 7297.306755858185, 7372.299631534996, 7407.260346042642, 29267.414651706422, 29518.0, 29644.851775740983, 30043.248918777204, 31365.0, 39620.0, 40141.19717605573, 40584.188316234104, 40662.39006414847, 40791.38812917868, 9647.421154730739, 9736.75658108553, 9872.851907221253, 9884.30809843304, 9903.158231550398, 10346.172306215636, 10431.321964072311, 10490.580376784843, 10729.731756706145, 11177.832332514856, 9003.684871029482, 9111.225545828678, 9150.222231110163, 9225.169734723908, 9238.491882946233, 9994.585438306158, 10213.0, 10245.0, 10269.897301027193, 10355.43045132525, 8610.397272190887, 8700.738977830675, 8960.507172105597, 9702.27232957517, 9714.854277185988, 9006.324525660733, 9015.413998090104, 9036.909630903607, 9372.95313523428, 9529.237660986966, 8075.676972921017, 8313.958430207811, 8374.49753014821, 8498.575071246289, 8657.09100544459], "unit": "score", "name": "yui.html", "value": 5412.880068823352}], "name": "dromaeo_css", "value": 6082.357300067477}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 108.0, 111.0, 112.0, 114.0, 100.0, 112.0, 111.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [155.0, 128.0, 155.0, 165.0, 131.0, 155.0, 158.0, 128.0, 165.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [161.0, 170.0, 160.0, 159.0, 162.0, 162.0, 161.0, 164.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 81.0, 91.0, 74.0, 82.0, 73.0, 94.0, 98.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 96.0, 98.0, 97.0, 141.0, 96.0, 98.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 71.0, 70.0, 70.0, 69.0, 79.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [92.0, 84.0, 84.0, 85.0, 84.0, 85.0, 92.0, 84.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [124.0, 137.0, 126.0, 120.0, 124.0, 117.0, 129.0, 119.0, 128.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [137.0, 148.0, 139.0, 139.0, 147.0, 137.0, 150.0, 149.0, 160.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 69.0, 69.0, 77.0, 68.0, 69.0, 69.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1524.6000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [187.68768768768768], "unit": "score", "name": "DeltaBlue", "value": 352.2767040000001}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [2024.2914979757086], "unit": "score", "name": "RayTrace", "value": 365.55456600000014}, {"lowerIsBetter": false, "replicates": [811.6883116883117], "unit": "score", "name": "Earley", "value": 821.0824160000001}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26710.526315789473], "unit": "score", "name": "RegExp", "value": 34.105842364532016}, {"lowerIsBetter": false, "replicates": [599.1611743559017], "unit": "score", "name": "Splay", "value": 136.00847899999997}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19735.214712075347}]} 11:35:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19735.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1524.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6082.36"}}} 11:35:38 INFO - Return code: 0 11:35:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:35:38 INFO - # TBPL SUCCESS # 11:35:38 INFO - Running post-action listener: _resource_record_post_action 11:35:38 INFO - Running post-run listener: _resource_record_post_run 11:35:39 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 8192; Write bytes: 547368960; Read time: 40; Write time: 753864 11:35:39 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 237756416; Read time: 0; Write time: 450136 11:35:39 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 8192; Write bytes: 309612544; Read time: 40; Write time: 303728 11:35:39 INFO - Running post-run listener: _upload_blobber_files 11:35:39 INFO - Blob upload gear active. 11:35:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:35:39 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 11:35:39 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', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:35:39 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 B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:35:39 INFO - (blobuploader) - INFO - Open directory for files ... 11:35:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:35:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:40 INFO - (blobuploader) - INFO - Done attempting. 11:35:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:35:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:35:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:41 INFO - (blobuploader) - INFO - Done attempting. 11:35:41 INFO - (blobuploader) - INFO - Iteration through files over. 11:35:41 INFO - Return code: 0 11:35:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:35:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:35:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/bd883d994b6acb20e2ce7672de9662a42947edd13d9f81e2d664f28621d2bece583304aa836f1d6f497f6bdd09480c11af10cb1528284b5b85ad4ac36545c25f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/21f0818e59274217c58ff95e7ef4f21ee057d663f05b5d7d9b2a6437750077a704f47694bd227ca73587a788a7855826c4340deca663b41f16ce87c73e1a2635"} 11:35:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:35:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:35:41 INFO - Contents: 11:35:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/bd883d994b6acb20e2ce7672de9662a42947edd13d9f81e2d664f28621d2bece583304aa836f1d6f497f6bdd09480c11af10cb1528284b5b85ad4ac36545c25f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/21f0818e59274217c58ff95e7ef4f21ee057d663f05b5d7d9b2a6437750077a704f47694bd227ca73587a788a7855826c4340deca663b41f16ce87c73e1a2635"} 11:35:41 INFO - Copying logs to upload dir... 11:35:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.984221 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-29 11:35:41.440189) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 11:35:41.443492) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/bd883d994b6acb20e2ce7672de9662a42947edd13d9f81e2d664f28621d2bece583304aa836f1d6f497f6bdd09480c11af10cb1528284b5b85ad4ac36545c25f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/21f0818e59274217c58ff95e7ef4f21ee057d663f05b5d7d9b2a6437750077a704f47694bd227ca73587a788a7855826c4340deca663b41f16ce87c73e1a2635"} build_url:https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/4KmR_j4RTyuQTyKquuxZ2w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/bd883d994b6acb20e2ce7672de9662a42947edd13d9f81e2d664f28621d2bece583304aa836f1d6f497f6bdd09480c11af10cb1528284b5b85ad4ac36545c25f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/21f0818e59274217c58ff95e7ef4f21ee057d663f05b5d7d9b2a6437750077a704f47694bd227ca73587a788a7855826c4340deca663b41f16ce87c73e1a2635"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 11:35:41.468145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:35:41.468487) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451416142.601094-1950943247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 11:35:41.552030) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 11:35:41.552389) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 11:35:41.552713) ========= ========= Total master_lag: 0.26 =========